builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1468909476.26 results: success (0) buildid: 20160718203032 builduid: 9cafc9a0e8fa4f7e92cb6858dbe95347 revision: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.261407) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.261883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.262158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.277962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.278314) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 23:24:36-- 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% 221M=0s 2016-07-18 23:24:36 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.369642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.370207) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:36.421177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 23:24:36.421600) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 --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 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 --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=2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 23:24:36,865 truncating revision to first 12 chars 2016-07-18 23:24:36,866 Setting DEBUG logging. 2016-07-18 23:24:36,866 attempt 1/10 2016-07-18 23:24:36,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77a5e8e87f91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 23:24:37,620 unpacking tar archive at: fx-team-77a5e8e87f91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.076811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 23:24:37.512526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:37.512865) ========= script_repo_revision: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:37.513266) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:37.513550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 23:24:37.524875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-18 23:24:37.525160) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:24:38 INFO - MultiFileLogger online at 20160718 23:24:38 in /builds/slave/test 23:24:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:24:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:38 INFO - {'append_to_log': False, 23:24:38 INFO - 'base_work_dir': '/builds/slave/test', 23:24:38 INFO - 'blob_upload_branch': 'Fx-Team', 23:24:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:38 INFO - 'branch': 'Fx-Team', 23:24:38 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:38 INFO - 'config_files': ('talos/linux_config.py',), 23:24:38 INFO - 'default_actions': ('clobber', 23:24:38 INFO - 'read-buildbot-config', 23:24:38 INFO - 'download-and-extract', 23:24:38 INFO - 'populate-webroot', 23:24:38 INFO - 'create-virtualenv', 23:24:38 INFO - 'install', 23:24:38 INFO - 'run-tests'), 23:24:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:38 INFO - 'download_minidump_stackwalk': True, 23:24:38 INFO - 'download_symbols': 'ondemand', 23:24:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:38 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:38 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:38 INFO - 'installer_path': 'installer.exe', 23:24:38 INFO - 'log_level': 'info', 23:24:38 INFO - 'log_name': 'talos', 23:24:38 INFO - 'log_to_console': True, 23:24:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:24:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:24:38 INFO - 'opt_config_files': (), 23:24:38 INFO - 'pip_index': False, 23:24:38 INFO - 'sps_profile': False, 23:24:38 INFO - 'sps_profile_interval': 0, 23:24:38 INFO - 'suite': 'dromaeojs-e10s', 23:24:38 INFO - 'system_bits': '32', 23:24:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:38 INFO - 'title': 'talos-linux64-ix-012', 23:24:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:38 INFO - 'use_talos_json': True, 23:24:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:38 INFO - 'work_dir': 'build'} 23:24:38 INFO - ##### 23:24:38 INFO - ##### Running clobber step. 23:24:38 INFO - ##### 23:24:38 INFO - Running pre-action listener: _resource_record_pre_action 23:24:38 INFO - Running main action method: clobber 23:24:38 INFO - rmtree: /builds/slave/test/build 23:24:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:39 INFO - Running post-action listener: _resource_record_post_action 23:24:39 INFO - ##### 23:24:39 INFO - ##### Finished clobber step (success) 23:24:39 INFO - ##### 23:24:39 INFO - ##### 23:24:39 INFO - ##### Running read-buildbot-config step. 23:24:39 INFO - ##### 23:24:39 INFO - Running pre-action listener: _resource_record_pre_action 23:24:39 INFO - Running main action method: read_buildbot_config 23:24:39 INFO - Using buildbot properties: 23:24:39 INFO - { 23:24:39 INFO - "project": "", 23:24:39 INFO - "product": "firefox", 23:24:39 INFO - "script_repo_revision": "production", 23:24:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:24:39 INFO - "repository": "", 23:24:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:24:39 INFO - "buildid": "20160718203032", 23:24:39 INFO - "pgo_build": "True", 23:24:39 INFO - "basedir": "/builds/slave/test", 23:24:39 INFO - "buildnumber": 941, 23:24:39 INFO - "slavename": "talos-linux64-ix-012", 23:24:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:24:39 INFO - "platform": "ubuntu64_hw", 23:24:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:24:39 INFO - "branch": "fx-team", 23:24:39 INFO - "repo_path": "integration/fx-team", 23:24:39 INFO - "revision": "77a5e8e87f91113dcf6cb15fdc83a184cc237e48", 23:24:39 INFO - "stage_platform": "linux64-pgo", 23:24:39 INFO - "builduid": "9cafc9a0e8fa4f7e92cb6858dbe95347", 23:24:39 INFO - "slavebuilddir": "test" 23:24:39 INFO - } 23:24:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:24:39 INFO - Running post-action listener: _resource_record_post_action 23:24:39 INFO - ##### 23:24:39 INFO - ##### Finished read-buildbot-config step (success) 23:24:39 INFO - ##### 23:24:39 INFO - ##### 23:24:39 INFO - ##### Running download-and-extract step. 23:24:39 INFO - ##### 23:24:39 INFO - Running pre-action listener: _resource_record_pre_action 23:24:39 INFO - Running main action method: download_and_extract 23:24:39 INFO - mkdir: /builds/slave/test/build/tests 23:24:39 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')]} 23:24:39 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:39 INFO - Downloaded 1361 bytes. 23:24:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:24:39 INFO - Using the following test package requirements: 23:24:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:24:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:24:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'jsshell-linux-x86_64.zip'], 23:24:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:24:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:24:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:24:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:24:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:24:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:24:39 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')]} 23:24:39 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:40 INFO - Downloaded 24333765 bytes. 23:24:40 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'] 23:24:40 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 23:24:42 INFO - Return code: 0 23:24:42 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 23:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:42 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:43 INFO - Downloaded 24333765 bytes. 23:24:43 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'] 23:24:43 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 23:24:44 INFO - Return code: 0 23:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:44 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:47 INFO - Downloaded 14403317 bytes. 23:24:47 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'] 23:24:47 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 23:24:47 INFO - Return code: 0 23:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:47 INFO - https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:24:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:24:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:24:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJyD6SOyT56_W-pB0m0lLw/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 23:24:49 INFO - Downloaded 60845064 bytes. 23:24:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:24:49 INFO - mkdir: /builds/slave/test/properties 23:24:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:49 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:49 INFO - Contents: 23:24:49 INFO - build_url:https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:24:50 INFO - Running post-action listener: _resource_record_post_action 23:24:50 INFO - Running post-action listener: set_extra_try_arguments 23:24:50 INFO - ##### 23:24:50 INFO - ##### Finished download-and-extract step (success) 23:24:50 INFO - ##### 23:24:50 INFO - ##### 23:24:50 INFO - ##### Running populate-webroot step. 23:24:50 INFO - ##### 23:24:50 INFO - Running pre-action listener: _resource_record_pre_action 23:24:50 INFO - Running main action method: populate_webroot 23:24:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:50 INFO - '--tppagecycles', 23:24:50 INFO - '7'], 23:24:50 INFO - 'tests': ['tsvgm']}}, 23:24:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['damp', 'tps']}, 23:24:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'tests': ['damp', 'tps']}, 23:24:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['dromaeo_dom']}, 23:24:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['basic_compositor_video']}, 23:24:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:24:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['a11yr', 23:24:50 INFO - 'ts_paint', 23:24:50 INFO - 'tpaint', 23:24:50 INFO - 'sessionrestore', 23:24:50 INFO - 'sessionrestore_no_auto_restore', 23:24:50 INFO - 'tabpaint']}, 23:24:50 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:50 INFO - 'ts_paint', 23:24:50 INFO - 'tpaint', 23:24:50 INFO - 'sessionrestore', 23:24:50 INFO - 'sessionrestore_no_auto_restore', 23:24:50 INFO - 'tabpaint']}, 23:24:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:50 INFO - 'ts_paint', 23:24:50 INFO - 'tpaint', 23:24:50 INFO - 'sessionrestore', 23:24:50 INFO - 'sessionrestore_no_auto_restore', 23:24:50 INFO - 'tabpaint']}, 23:24:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:50 INFO - 'ts_paint', 23:24:50 INFO - 'tpaint', 23:24:50 INFO - 'sessionrestore', 23:24:50 INFO - 'sessionrestore_no_auto_restore', 23:24:50 INFO - 'tabpaint']}, 23:24:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['a11yr', 23:24:50 INFO - 'ts_paint', 23:24:50 INFO - 'tpaint', 23:24:50 INFO - 'sessionrestore', 23:24:50 INFO - 'sessionrestore_no_auto_restore', 23:24:50 INFO - 'tabpaint']}, 23:24:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['a11yr', 23:24:50 INFO - 'ts_paint', 23:24:50 INFO - 'tpaint', 23:24:50 INFO - 'sessionrestore', 23:24:50 INFO - 'sessionrestore_no_auto_restore', 23:24:50 INFO - 'tabpaint']}, 23:24:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['tsvgx', 23:24:50 INFO - 'tsvgr_opacity', 23:24:50 INFO - 'tart', 23:24:50 INFO - 'tscrollx', 23:24:50 INFO - 'cart']}, 23:24:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:50 INFO - 'tsvgr_opacity', 23:24:50 INFO - 'tart', 23:24:50 INFO - 'tscrollx', 23:24:50 INFO - 'cart']}, 23:24:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'talos_options': ['--disable-e10s'], 23:24:50 INFO - 'tests': ['tp5o']}, 23:24:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'tests': ['tp5o']}, 23:24:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'talos_options': ['--disable-e10s', 23:24:50 INFO - '--xperf_path', 23:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:50 INFO - 'tests': ['tp5n']}, 23:24:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:50 INFO - 'talos_options': ['--xperf_path', 23:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:50 INFO - 'tests': ['tp5n']}}, 23:24:50 INFO - 'talos.zip': {'path': '', 23:24:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:50 INFO - Running post-action listener: _resource_record_post_action 23:24:50 INFO - ##### 23:24:50 INFO - ##### Finished populate-webroot step (success) 23:24:50 INFO - ##### 23:24:50 INFO - ##### 23:24:50 INFO - ##### Running create-virtualenv step. 23:24:50 INFO - ##### 23:24:50 INFO - Running pre-action listener: _resource_record_pre_action 23:24:50 INFO - Running main action method: create_virtualenv 23:24:50 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:50 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 23:24:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:51 INFO - Using real prefix '/usr' 23:24:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:51 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:53 INFO - Installing pip.................done. 23:24:53 INFO - Return code: 0 23:24:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:24:53 INFO - Using env: {'DISPLAY': ':0', 23:24:53 INFO - 'HOME': '/home/cltbld', 23:24:53 INFO - 'LANG': 'en_US.UTF-8', 23:24:53 INFO - 'LANGUAGE': 'en_US:en', 23:24:53 INFO - 'LOGNAME': 'cltbld', 23:24:53 INFO - 'MAIL': '/var/mail/cltbld', 23:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:53 INFO - 'MOZ_NO_REMOTE': '1', 23:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:53 INFO - 'NO_EM_RESTART': '1', 23:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:53 INFO - 'PWD': '/builds/slave/test', 23:24:53 INFO - 'SHELL': '/bin/bash', 23:24:53 INFO - 'SHLVL': '1', 23:24:53 INFO - 'TERM': 'linux', 23:24:53 INFO - 'TMOUT': '86400', 23:24:53 INFO - 'USER': 'cltbld', 23:24:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:53 INFO - '_': '/tools/buildbot/bin/python'} 23:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:53 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 23:24:53 INFO - Cleaning up... 23:24:53 INFO - Return code: 0 23:24:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:24:53 INFO - Using env: {'DISPLAY': ':0', 23:24:53 INFO - 'HOME': '/home/cltbld', 23:24:53 INFO - 'LANG': 'en_US.UTF-8', 23:24:53 INFO - 'LANGUAGE': 'en_US:en', 23:24:53 INFO - 'LOGNAME': 'cltbld', 23:24:53 INFO - 'MAIL': '/var/mail/cltbld', 23:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:53 INFO - 'MOZ_NO_REMOTE': '1', 23:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:53 INFO - 'NO_EM_RESTART': '1', 23:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:53 INFO - 'PWD': '/builds/slave/test', 23:24:53 INFO - 'SHELL': '/bin/bash', 23:24:53 INFO - 'SHLVL': '1', 23:24:53 INFO - 'TERM': 'linux', 23:24:53 INFO - 'TMOUT': '86400', 23:24:53 INFO - 'USER': 'cltbld', 23:24:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:53 INFO - '_': '/tools/buildbot/bin/python'} 23:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:53 INFO - Downloading/unpacking psutil>=3.1.1 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:55 INFO - Installing collected packages: psutil 23:24:55 INFO - Running setup.py install for psutil 23:24:55 INFO - building 'psutil._psutil_linux' extension 23:24:55 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 23:24:56 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 23:24:56 INFO - building 'psutil._psutil_posix' extension 23:24:56 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 23:24:56 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 23:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:56 INFO - Successfully installed psutil 23:24:56 INFO - Cleaning up... 23:24:56 INFO - Return code: 0 23:24:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:24:56 INFO - Using env: {'DISPLAY': ':0', 23:24:56 INFO - 'HOME': '/home/cltbld', 23:24:56 INFO - 'LANG': 'en_US.UTF-8', 23:24:56 INFO - 'LANGUAGE': 'en_US:en', 23:24:56 INFO - 'LOGNAME': 'cltbld', 23:24:56 INFO - 'MAIL': '/var/mail/cltbld', 23:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:56 INFO - 'MOZ_NO_REMOTE': '1', 23:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:56 INFO - 'NO_EM_RESTART': '1', 23:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:56 INFO - 'PWD': '/builds/slave/test', 23:24:56 INFO - 'SHELL': '/bin/bash', 23:24:56 INFO - 'SHLVL': '1', 23:24:56 INFO - 'TERM': 'linux', 23:24:56 INFO - 'TMOUT': '86400', 23:24:56 INFO - 'USER': 'cltbld', 23:24:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:56 INFO - '_': '/tools/buildbot/bin/python'} 23:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:24:56 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 23:24:56 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 23:24:56 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 23:24:56 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 23:24:56 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 23:24:56 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 23:24:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:24:58 INFO - Installing collected packages: mozsystemmonitor 23:24:58 INFO - Running setup.py install for mozsystemmonitor 23:24:58 INFO - Successfully installed mozsystemmonitor 23:24:58 INFO - Cleaning up... 23:24:58 INFO - Return code: 0 23:24:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:24:58 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')]} 23:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:58 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')]} 23:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:58 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 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:24:58 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 23:24:58 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 23:24:58 INFO - Using env: {'DISPLAY': ':0', 23:24:58 INFO - 'HOME': '/home/cltbld', 23:24:58 INFO - 'LANG': 'en_US.UTF-8', 23:24:58 INFO - 'LANGUAGE': 'en_US:en', 23:24:58 INFO - 'LOGNAME': 'cltbld', 23:24:58 INFO - 'MAIL': '/var/mail/cltbld', 23:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:58 INFO - 'MOZ_NO_REMOTE': '1', 23:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:58 INFO - 'NO_EM_RESTART': '1', 23:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:58 INFO - 'PWD': '/builds/slave/test', 23:24:58 INFO - 'SHELL': '/bin/bash', 23:24:58 INFO - 'SHLVL': '1', 23:24:58 INFO - 'TERM': 'linux', 23:24:58 INFO - 'TMOUT': '86400', 23:24:58 INFO - 'USER': 'cltbld', 23:24:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:58 INFO - '_': '/tools/buildbot/bin/python'} 23:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:58 INFO - Downloading/unpacking jsonschema==2.5.1 23:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:25:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:25:00 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 23:25:00 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 23:25:00 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 23:25:00 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 23:25:00 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 23:25:00 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 23:25:01 INFO - Downloading functools32-3.2.3-2.tar.gz 23:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:25:01 INFO - warning: no files found matching '*.txt' 23:25:01 INFO - no previously-included directories found matching 'build' 23:25:01 INFO - no previously-included directories found matching 'dist' 23:25:01 INFO - no previously-included directories found matching '.git*' 23:25:01 INFO - Installing collected packages: jsonschema, functools32 23:25:01 INFO - Running setup.py install for functools32 23:25:01 INFO - warning: no files found matching '*.txt' 23:25:01 INFO - no previously-included directories found matching 'build' 23:25:01 INFO - no previously-included directories found matching 'dist' 23:25:01 INFO - no previously-included directories found matching '.git*' 23:25:01 INFO - Successfully installed jsonschema functools32 23:25:01 INFO - Cleaning up... 23:25:01 INFO - Return code: 0 23:25:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:25:01 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')]} 23:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:01 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')]} 23:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:01 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 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:25:01 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 23:25:01 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 23:25:01 INFO - Using env: {'DISPLAY': ':0', 23:25:01 INFO - 'HOME': '/home/cltbld', 23:25:01 INFO - 'LANG': 'en_US.UTF-8', 23:25:01 INFO - 'LANGUAGE': 'en_US:en', 23:25:01 INFO - 'LOGNAME': 'cltbld', 23:25:01 INFO - 'MAIL': '/var/mail/cltbld', 23:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:01 INFO - 'MOZ_NO_REMOTE': '1', 23:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:01 INFO - 'NO_EM_RESTART': '1', 23:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:01 INFO - 'PWD': '/builds/slave/test', 23:25:01 INFO - 'SHELL': '/bin/bash', 23:25:01 INFO - 'SHLVL': '1', 23:25:01 INFO - 'TERM': 'linux', 23:25:01 INFO - 'TMOUT': '86400', 23:25:01 INFO - 'USER': 'cltbld', 23:25:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:01 INFO - '_': '/tools/buildbot/bin/python'} 23:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:01 INFO - Downloading/unpacking blobuploader==1.2.4 23:25:01 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 23:25:01 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 23:25:01 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 23:25:01 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 23:25:01 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 23:25:01 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 23:25:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:25:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:25:03 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 23:25:03 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 23:25:03 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 23:25:03 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 23:25:03 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 23:25:03 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 23:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:25:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:25:03 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 23:25:03 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 23:25:03 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 23:25:03 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 23:25:03 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 23:25:03 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 23:25:04 INFO - Downloading docopt-0.6.1.tar.gz 23:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:25:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:25:04 INFO - Running setup.py install for blobuploader 23:25:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:25:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:25:04 INFO - Running setup.py install for requests 23:25:04 INFO - Running setup.py install for docopt 23:25:04 INFO - Successfully installed blobuploader requests docopt 23:25:04 INFO - Cleaning up... 23:25:04 INFO - Return code: 0 23:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:04 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')]} 23:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:04 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')]} 23:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:04 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 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:25:04 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 23:25:04 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 23:25:04 INFO - Using env: {'DISPLAY': ':0', 23:25:04 INFO - 'HOME': '/home/cltbld', 23:25:04 INFO - 'LANG': 'en_US.UTF-8', 23:25:04 INFO - 'LANGUAGE': 'en_US:en', 23:25:04 INFO - 'LOGNAME': 'cltbld', 23:25:04 INFO - 'MAIL': '/var/mail/cltbld', 23:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:04 INFO - 'MOZ_NO_REMOTE': '1', 23:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:04 INFO - 'NO_EM_RESTART': '1', 23:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:04 INFO - 'PWD': '/builds/slave/test', 23:25:04 INFO - 'SHELL': '/bin/bash', 23:25:04 INFO - 'SHLVL': '1', 23:25:04 INFO - 'TERM': 'linux', 23:25:04 INFO - 'TMOUT': '86400', 23:25:04 INFO - 'USER': 'cltbld', 23:25:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:04 INFO - '_': '/tools/buildbot/bin/python'} 23:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:05 INFO - Running setup.py (path:/tmp/pip-50Pf8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:05 INFO - Running setup.py (path:/tmp/pip-5jqH19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:05 INFO - Running setup.py (path:/tmp/pip-ofEXNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:05 INFO - Running setup.py (path:/tmp/pip-IyVD4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:05 INFO - Running setup.py (path:/tmp/pip-E0Mio9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:05 INFO - Running setup.py (path:/tmp/pip-9XESgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:05 INFO - Running setup.py (path:/tmp/pip-Who3uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:05 INFO - Running setup.py (path:/tmp/pip-0TCUFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:05 INFO - Running setup.py (path:/tmp/pip-IOp2GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:05 INFO - Running setup.py (path:/tmp/pip-_GCzwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:05 INFO - Running setup.py (path:/tmp/pip-0rVLFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:05 INFO - Running setup.py (path:/tmp/pip-zvMyZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:05 INFO - Running setup.py (path:/tmp/pip-ZjJ30k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:06 INFO - Running setup.py (path:/tmp/pip-pmnp84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:06 INFO - Running setup.py (path:/tmp/pip-FzxYSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:06 INFO - Running setup.py (path:/tmp/pip-W4qp9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:06 INFO - Running setup.py (path:/tmp/pip-cdd0bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:25:06 INFO - Running setup.py install for manifestparser 23:25:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:25:06 INFO - Running setup.py install for mozcrash 23:25:06 INFO - Running setup.py install for mozdebug 23:25:06 INFO - Running setup.py install for mozdevice 23:25:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:25:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:25:06 INFO - Running setup.py install for mozfile 23:25:06 INFO - Running setup.py install for mozhttpd 23:25:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:25:06 INFO - Running setup.py install for mozinfo 23:25:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Running setup.py install for mozInstall 23:25:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Running setup.py install for mozleak 23:25:07 INFO - Running setup.py install for mozlog 23:25:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Running setup.py install for moznetwork 23:25:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Running setup.py install for mozprocess 23:25:07 INFO - Running setup.py install for mozprofile 23:25:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Running setup.py install for mozrunner 23:25:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:25:07 INFO - Running setup.py install for mozscreenshot 23:25:07 INFO - Running setup.py install for moztest 23:25:07 INFO - Running setup.py install for mozversion 23:25:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:25:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:25:08 INFO - Cleaning up... 23:25:08 INFO - Return code: 0 23:25:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:08 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')]} 23:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:08 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')]} 23:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:08 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 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:25:08 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 23:25:08 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 23:25:08 INFO - Using env: {'DISPLAY': ':0', 23:25:08 INFO - 'HOME': '/home/cltbld', 23:25:08 INFO - 'LANG': 'en_US.UTF-8', 23:25:08 INFO - 'LANGUAGE': 'en_US:en', 23:25:08 INFO - 'LOGNAME': 'cltbld', 23:25:08 INFO - 'MAIL': '/var/mail/cltbld', 23:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:08 INFO - 'MOZ_NO_REMOTE': '1', 23:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:08 INFO - 'NO_EM_RESTART': '1', 23:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:08 INFO - 'PWD': '/builds/slave/test', 23:25:08 INFO - 'SHELL': '/bin/bash', 23:25:08 INFO - 'SHLVL': '1', 23:25:08 INFO - 'TERM': 'linux', 23:25:08 INFO - 'TMOUT': '86400', 23:25:08 INFO - 'USER': 'cltbld', 23:25:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:08 INFO - '_': '/tools/buildbot/bin/python'} 23:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:08 INFO - Running setup.py (path:/tmp/pip-Dega0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:08 INFO - Running setup.py (path:/tmp/pip-KRM8x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:08 INFO - Running setup.py (path:/tmp/pip-Zackiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:08 INFO - Running setup.py (path:/tmp/pip-y7W2gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:08 INFO - Running setup.py (path:/tmp/pip-rTGXJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:08 INFO - Running setup.py (path:/tmp/pip-94hIDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:08 INFO - Running setup.py (path:/tmp/pip-wuAlI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:08 INFO - Running setup.py (path:/tmp/pip-zyADPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:08 INFO - Running setup.py (path:/tmp/pip-S1ofKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:08 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)) 23:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:08 INFO - Running setup.py (path:/tmp/pip-47vBj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:09 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)) 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:09 INFO - Running setup.py (path:/tmp/pip-c2P3eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:09 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)) 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:09 INFO - Running setup.py (path:/tmp/pip-dFAZ5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:09 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)) 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:09 INFO - Running setup.py (path:/tmp/pip-ceaVCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:09 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)) 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:09 INFO - Running setup.py (path:/tmp/pip-ZxAfjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:09 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)) 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:09 INFO - Running setup.py (path:/tmp/pip-KQPhS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:09 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)) 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:09 INFO - Running setup.py (path:/tmp/pip-lt0gUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:09 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)) 23:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:09 INFO - Running setup.py (path:/tmp/pip-oLJIYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:09 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)) 23:25:09 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)) 23:25:09 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)) 23:25:09 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)) 23:25:09 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)) 23:25:09 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)) 23:25:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25: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 23:25:12 INFO - Downloading blessings-1.6.tar.gz 23:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:25:12 INFO - Installing collected packages: blessings 23:25:12 INFO - Running setup.py install for blessings 23:25:12 INFO - Successfully installed blessings 23:25:12 INFO - Cleaning up... 23:25:12 INFO - Return code: 0 23:25:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:12 INFO - Reading from file tmpfile_stdout 23:25:12 INFO - Current package versions: 23:25:12 INFO - argparse == 1.2.1 23:25:12 INFO - blessings == 1.6 23:25:12 INFO - blobuploader == 1.2.4 23:25:12 INFO - docopt == 0.6.1 23:25:12 INFO - functools32 == 3.2.3-2 23:25:12 INFO - jsonschema == 2.5.1 23:25:12 INFO - manifestparser == 1.1 23:25:12 INFO - mozInstall == 1.12 23:25:12 INFO - mozcrash == 0.17 23:25:12 INFO - mozdebug == 0.1 23:25:12 INFO - mozdevice == 0.48 23:25:12 INFO - mozfile == 1.2 23:25:12 INFO - mozhttpd == 0.7 23:25:12 INFO - mozinfo == 0.9 23:25:12 INFO - mozleak == 0.1 23:25:12 INFO - mozlog == 3.2 23:25:12 INFO - moznetwork == 0.27 23:25:12 INFO - mozprocess == 0.23 23:25:12 INFO - mozprofile == 0.28 23:25:12 INFO - mozrunner == 6.12 23:25:12 INFO - mozscreenshot == 0.1 23:25:12 INFO - mozsystemmonitor == 0.3 23:25:12 INFO - moztest == 0.7 23:25:12 INFO - mozversion == 1.4 23:25:12 INFO - psutil == 3.1.1 23:25:12 INFO - requests == 1.2.3 23:25:12 INFO - wsgiref == 0.1.2 23:25:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:12 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')]} 23:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:12 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')]} 23:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:12 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 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:25:12 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 23:25:12 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 23:25:12 INFO - Using env: {'DISPLAY': ':0', 23:25:12 INFO - 'HOME': '/home/cltbld', 23:25:12 INFO - 'LANG': 'en_US.UTF-8', 23:25:12 INFO - 'LANGUAGE': 'en_US:en', 23:25:12 INFO - 'LOGNAME': 'cltbld', 23:25:12 INFO - 'MAIL': '/var/mail/cltbld', 23:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:12 INFO - 'MOZ_NO_REMOTE': '1', 23:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:12 INFO - 'NO_EM_RESTART': '1', 23:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:12 INFO - 'PWD': '/builds/slave/test', 23:25:12 INFO - 'SHELL': '/bin/bash', 23:25:12 INFO - 'SHLVL': '1', 23:25:12 INFO - 'TERM': 'linux', 23:25:12 INFO - 'TMOUT': '86400', 23:25:12 INFO - 'USER': 'cltbld', 23:25:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:12 INFO - '_': '/tools/buildbot/bin/python'} 23:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 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)) 23:25:13 INFO - Cleaning up... 23:25:13 INFO - Return code: 0 23:25:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:25: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')]} 23:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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')]} 23:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:13 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 0x1801030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', '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 23:25:13 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 23:25:13 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 23:25:13 INFO - Using env: {'DISPLAY': ':0', 23:25:13 INFO - 'HOME': '/home/cltbld', 23:25:13 INFO - 'LANG': 'en_US.UTF-8', 23:25:13 INFO - 'LANGUAGE': 'en_US:en', 23:25:13 INFO - 'LOGNAME': 'cltbld', 23:25:13 INFO - 'MAIL': '/var/mail/cltbld', 23:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:13 INFO - 'MOZ_NO_REMOTE': '1', 23:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:13 INFO - 'NO_EM_RESTART': '1', 23:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:13 INFO - 'PWD': '/builds/slave/test', 23:25:13 INFO - 'SHELL': '/bin/bash', 23:25:13 INFO - 'SHLVL': '1', 23:25:13 INFO - 'TERM': 'linux', 23:25:13 INFO - 'TMOUT': '86400', 23:25:13 INFO - 'USER': 'cltbld', 23:25:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:13 INFO - '_': '/tools/buildbot/bin/python'} 23:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:25:13 INFO - Cleaning up... 23:25:13 INFO - Return code: 0 23:25:13 INFO - Running post-action listener: _resource_record_post_action 23:25:13 INFO - Running post-action listener: _start_resource_monitoring 23:25:13 INFO - Starting resource monitoring. 23:25:13 INFO - ##### 23:25:13 INFO - ##### Finished create-virtualenv step (success) 23:25:13 INFO - ##### 23:25:13 INFO - ##### 23:25:13 INFO - ##### Running install step. 23:25:13 INFO - ##### 23:25:13 INFO - Running pre-action listener: _resource_record_pre_action 23:25:13 INFO - Running main action method: install 23:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:13 INFO - Reading from file tmpfile_stdout 23:25:13 INFO - Detecting whether we're running mozinstall >=1.0... 23:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:25:13 INFO - Reading from file tmpfile_stdout 23:25:13 INFO - Output received: 23:25:13 INFO - Usage: mozinstall [options] installer 23:25:13 INFO - Options: 23:25:13 INFO - -h, --help show this help message and exit 23:25:13 INFO - -d DEST, --destination=DEST 23:25:13 INFO - Directory to install application into. [default: 23:25:13 INFO - "/builds/slave/test"] 23:25:13 INFO - --app=APP Application being installed. [default: firefox] 23:25:13 INFO - mkdir: /builds/slave/test/build/application 23:25:13 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'] 23:25:13 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 23:25:30 INFO - Reading from file tmpfile_stdout 23:25:30 INFO - Output received: 23:25:30 INFO - /builds/slave/test/build/application/firefox/firefox 23:25:30 INFO - Running post-action listener: _resource_record_post_action 23:25:30 INFO - ##### 23:25:30 INFO - ##### Finished install step (success) 23:25:30 INFO - ##### 23:25:30 INFO - ##### 23:25:30 INFO - ##### Running run-tests step. 23:25:30 INFO - ##### 23:25:30 INFO - Running pre-action listener: _resource_record_pre_action 23:25:30 INFO - Running main action method: run_tests 23:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:30 INFO - Python 2.7.3 23:25:30 INFO - Return code: 0 23:25:30 INFO - grabbing minidump binary from tooltool 23:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:30 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 0x1ac03b0>, '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 0x1ac12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:30 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 23:25:30 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 23:25:30 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 23:25:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:31 INFO - Return code: 0 23:25:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:25:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:25:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 23:25:31 INFO - Using env: {'DISPLAY': ':0', 23:25:31 INFO - 'HOME': '/home/cltbld', 23:25:31 INFO - 'LANG': 'en_US.UTF-8', 23:25:31 INFO - 'LANGUAGE': 'en_US:en', 23:25:31 INFO - 'LOGNAME': 'cltbld', 23:25:31 INFO - 'MAIL': '/var/mail/cltbld', 23:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:31 INFO - 'MOZ_NO_REMOTE': '1', 23:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:31 INFO - 'NO_EM_RESTART': '1', 23:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:31 INFO - 'PWD': '/builds/slave/test', 23:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:31 INFO - 'SHELL': '/bin/bash', 23:25:31 INFO - 'SHLVL': '1', 23:25:31 INFO - 'TERM': 'linux', 23:25:31 INFO - 'TMOUT': '86400', 23:25:31 INFO - 'USER': 'cltbld', 23:25:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090', 23:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:31 INFO - '_': '/tools/buildbot/bin/python'} 23:25:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:25:31 INFO - mozversion application_buildid: 20160718203032 23:25:31 INFO - mozversion application_changeset: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 23:25:31 INFO - mozversion application_display_name: Nightly 23:25:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:31 INFO - mozversion application_name: Firefox 23:25:31 INFO - mozversion application_remotingname: firefox 23:25:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:25:31 INFO - mozversion application_vendor: Mozilla 23:25:31 INFO - mozversion application_version: 50.0a1 23:25:31 INFO - mozversion platform_buildid: 20160718203032 23:25:31 INFO - mozversion platform_changeset: 77a5e8e87f91113dcf6cb15fdc83a184cc237e48 23:25:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:25:31 INFO - mozversion platform_version: 50.0a1 23:25:31 INFO - using testdate: 1468909531 23:25:31 INFO - actual date: 1468909531 23:25:31 INFO - starting webserver on 'localhost:52925' 23:25:31 INFO - SUITE-START | Running 2 tests 23:25:31 INFO - TEST-START | dromaeo_css 23:25:31 INFO - operating with platform_type : linux_ 23:25:31 INFO - Initialising browser for dromaeo_css test... 23:25:31 INFO - TEST-INFO | started process 30875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtybLp/profile http://localhost:52925/getInfo.html) 23:25:35 INFO - PROCESS | 30875 | __metrics Screen width/height:1600/1200 23:25:35 INFO - PROCESS | 30875 | colorDepth:24 23:25:35 INFO - PROCESS | 30875 | Browser inner width/height: 1024/697 23:25:35 INFO - PROCESS | 30875 | __metrics 23:25:35 ERROR - PROCESS | 30875 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 23:25:36 INFO - TEST-INFO | 30875: exit 0 23:25:36 INFO - Browser initialized. 23:25:36 INFO - Running cycle 1/1 for dromaeo_css test... 23:25:36 INFO - TEST-INFO | started process 30995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtybLp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:48 INFO - PROCESS | 30995 | RSS: Main: 167747584 23:25:48 INFO - PROCESS | 30995 | 23:26:38 INFO - PROCESS | 30995 | 1468909598004 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] 23:28:46 INFO - PROCESS | 30995 | Cycle 1(1): loaded http://localhost:52925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52925/tests/dromaeo/cssquery-ext.html) 23:28:47 INFO - PROCESS | 30995 | RSS: Main: 172040192 23:28:47 INFO - PROCESS | 30995 | 23:31:49 INFO - PROCESS | 30995 | Cycle 1(1): loaded http://localhost:52925/tests/dromaeo/cssquery-ext.html (next: http://localhost:52925/tests/dromaeo/cssquery-jquery.html) 23:31:50 INFO - PROCESS | 30995 | RSS: Main: 169349120 23:31:50 INFO - PROCESS | 30995 | 23:34:51 INFO - PROCESS | 30995 | Cycle 1(1): loaded http://localhost:52925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52925/tests/dromaeo/cssquery-mootools.html) 23:34:52 INFO - PROCESS | 30995 | RSS: Main: 172785664 23:34:52 INFO - PROCESS | 30995 | 23:37:54 INFO - PROCESS | 30995 | Cycle 1(1): loaded http://localhost:52925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52925/tests/dromaeo/cssquery-prototype.html) 23:37:54 INFO - PROCESS | 30995 | RSS: Main: 166686720 23:37:54 INFO - PROCESS | 30995 | 23:40:57 INFO - PROCESS | 30995 | Cycle 1(1): loaded http://localhost:52925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52925/tests/dromaeo/cssquery-yui.html) 23:40:58 INFO - PROCESS | 30995 | RSS: Main: 168808448 23:40:58 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | Cycle 1(1): loaded http://localhost:52925/tests/dromaeo/cssquery-yui.html (next: http://localhost:52925/tests/dromaeo/cssquery-dojo.html) 23:44:00 INFO - PROCESS | 30995 | RSS: Main: 169521152 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | __start_tp_report 23:44:00 INFO - PROCESS | 30995 | _x_x_mozilla_page_load 23:44:00 INFO - PROCESS | 30995 | _x_x_mozilla_page_load_details 23:44:00 INFO - PROCESS | 30995 | |i|pagename|runs| 23:44:00 INFO - PROCESS | 30995 | |0;dojo.html;3049.3139043715164;3071.4317851197543;3075.1082186166004;3083.5528848316994;3096.7367773739215;5332.8534365111545;5354.892902141954;5368.221607866862;5377.704226267554;5403.351597808259;5237.10969135247;5297.788088476456;5299.735013249341;5328.573714102872;5353.866153346168;4839.927401088987;4865.537773911473;4909.582685471739;4950.603951683856;4984.451710311862;4924.507549245082;4949.331840201581;5036.974815125919;5050.065737838511;5086.618503612225;4880.219164933594;4984.750762461862;5012.498750124995;5013.924791128136;5023.995200959805;4935.333729946447;4937.506249375069;4938.851834444972;4948.604111671094;4989.700617962933;4890.193118135503;4892.119418504668;4893.975530122327;4922;4944.678595891256;5222.399424066243;5229.37247530295;5287.68273903567;5419.268398766156;5457.263269458612;5679.204911312419;5689.630174038715;5696.060150075233;5710.600257981943;5756;5739.827805165852;5754.625949313281;5755.625884317506;5758.769649214027;5759.740811663485;5273.182656688219;5340.092184328673;5350.91973620396;5368.8657783554945;5390.434004429479;5891.46976772084;5901.291844978544;5914.260717410324;5919.4080591940465;5935.080062590306;5659.377468478464;5670.829875103754;5679.488846003879;5680.914786278209;5681.403452637496;5520.585956053312;5650.180723795027;5674.631148975386;5714.314282286069;5733.254676891977;5672.801451949162;5686.886262274814;5689.573282003867;5689.68706721126;5689.971550142222;5595.412481689364;5680.857978550569;5715.314162300468;5717.571182161355;5736.4550367715;4294.613484786384;4339.891502712458;4344.54382289855;4352.173087113439;4397;3901.51231096113;3933.095388060705;3938.822752976123;3943.526776786804;3968.027833180889;5302.575793936476;5447.53695935842;5474.562035037187;5477.1510415885605;5520.861978450571;5664.631798933056;5709.857253568694;5746.856328591819;5750.88498230033;5768.394318596487;5449.591280653967;5451.781928722886;5468.343798744097;5473.562115030788;5481.561475081984;4946.727929963815;4976.0794253063295;4977.1538838397555;5015.899682006339;5026.623003274769;5949.196858424144;5949.613275137102;5963.4334738199805;5974.193483879708;5987.221661184019;5577.77688892456;5696.458836410535;5780.959427303126;5797;5805.245318108618;5906.26171728534;5908.881822363614;5962.105684147413;5967.46292833647;6038.849028774316;5609.747561359667;5674.120511320752;5677.290338707661;5688.886222275614;5713.257276554022;5564.054110801093;5695.060315047971;5696.088625819849;5786.681732504752;5806.883862322646;5650.689212093374;5666.093425051972;5674.319081710221;5684;5688.345840228427;5656.264685590847;5659.207710920557;5659.745311460912;5662.235598194191;5677.063284558001;5465.726713664221;5558.305211848519;5578.107502799533;5607.74765135578;5645.943540564706;5613.101903695389;5658.830235092789;5709.25779648643;5718.085106382959;5754.6547207167705;5565.30433695788;5577.581681373832;5586.636868603528;5594.440555944373;5615.747291371817 23:44:00 INFO - PROCESS | 30995 | |1;ext.html;547.5688605736211;587.1926101610286;593.4718100890209;602.4337123104283;607.7325976570306;40436.393454098215;44499.11001779963;44741.55258447414;44929;44984.10031799362;43495.56504434955;43634.56365436345;43641.781791091;43857.34213986785;44198.33702494465;8805.603747831346;9009.909900901006;9021.503817290046;9029.729108126767;9060.864087038699;8906.554672266393;8922.643094276222;8934.910650893506;8953.59708813105;8990.145936136056;9051.411658242194;9104.089591040876;9106.77233069172;9109;9116.908830911672;8941.642334306653;9018.413803102778;9029.41308814925;9049.864252036225;9083.137101975302;8911;8924.598393072327;8938.776530586721;8965.506897120657;8980.236679882219;41896.37155442671;42487.150256994995;42695.78652106751;42747.57252427467;42781.57218427807;3647.8905632831056;3672.8530858765616;3796.2976849282973;3866.478025466582;4232.78836058199;33125.6687433125;33183.170420739436;33231.667683323096;33405;33439;4277.935830962538;4387.3857659927635;4416.690831641787;4455.621272191867;4521.186186486431;361289;361856;362091;362645.9999999974;363497;34921.301573968376;36447.27105457876;58766.706166468895;59704.402955970756;59802.40197597969;37557;37604.43593346102;37731.81134094367;37840;37874;15856.52430427089;15888.046717197005;15924.363025479082;15935.840641593668;15946.441874534336;13289.93355033238;13364.73270534584;13402;13437.664058398619;13454.730905382034;8409.873851892227;8416.368772342099;8465.280451161598;8525.786855328543;8596.785080372916;3174.3175217328385;3294.2423242653845;3305.9834700826823;3313.618933822593;3348.096014076186;940.4780346907395;1031.5970280418624;1090.7705175221117;1091.6015654286127;1114.6711720042445;31419.214519637193;31458.842705786323;31647.20881977969;31697.20756981094;31943.840280798446;1116.5031560955458;1144.822552504363;1155.6764106050318;1217.2027322104036;1231.876812318761;16102.19489025544;16451.83548164527;16464;16780.160991950353;16821;618567;621166;628633;629490;631006;61595;62098.379016210165;62131.689341553;62139.37860621426;62291;1331.1613683379603;1336.933153342329;1347.905646604748;1358.2122369025942;1362.1826903857607;29969.550456743604;30352.571794255964;30463;30832.229194270323;31370;51903.480965191375;52831.20753188782;52916.470835291155;53015;53023.73488132535;422990;424895;425208;426303;427447;28652.85673571619;28794.85602571974;29362.412751745273;29442.411151777273;29549.409011820073;50474.242886356;51128;51427.74286128546;51598.09818067278;51850.48149518456;42643.36034959416;43252.35121473118;43945.34081988837;44048;45061;42901.78549107235;43109.78445107755;43168.35247471353;43577.346339804295;45080.323795142445;41854.79072604617;42703.57296426996;42919.57080429281;43130.78434607807;45481.54518454773;37144.814275928446;39184.21631567409;39371.409428858016;40182;40443.59556404516;28971;29312.26719332034;29323.41353172967;29437;29630.703692962794 23:44:00 INFO - PROCESS | 30995 | |2;jquery.html;391.1999960081633;392.2625464127441;398.874354578308;400.1077596958782;415.279490084703;14173.433062677506;18809.24763009478;19040.09599040097;20662.89668551657;20891.686624700622;18511.629767404676;18809.341673041446;19280.132394042266;20606.79393206071;20666.48333791656;5716.742746576404;5804.419558044204;5871.471567558919;5882.529397648178;5883.17635531026;5661.094224923992;5707.800226992056;5798.884022319551;5831.620944638585;5837.620554663955;5724.427557244284;5734.684592347419;5885.617434866741;5897.764089436418;5904.88190236195;5800.593958422912;5831.766729330843;5836.854078648046;5844.503217226541;5863.589548731569;5028.371453568304;5074.644774865761;5094.821681241176;5113.872153196163;5117.2068329409;23852.52294954091;24157;24221.273361799173;24314.149004784747;24869.25392238236;2528.40582463121;2562.581918398072;2618;2638.1689767723296;3069.3554353585773;14750.852491475056;14859.777103343458;15186.924065379713;15661.608459788482;15666.373345066298;1972.6350625134396;1981.2471260920902;1993.7408136942104;2032.2886989553538;2094.7276854008883;76627;85020;86071.56964215139;87128.5643571778;89237;10487.161027117812;10761.46192690378;10788.622398216181;10908.727281817859;11153.38656373891;15275.38898444072;15285.859979602865;15343.232838358037;15354.232288385536;15475.845241547666;8297.58512074406;8422.326213902874;8472.04048882854;8531.189536993976;8648.870266946002;8160.959195203986;8199.467034642728;8223.259906608433;8470.66117355299;8538.743837684879;6608.107905432801;6703.832404189837;6727.697253623599;6799.830004249933;6957.408620267232;1908.675525160726;1959.6864501679663;1980.7623085229577;1982.2071171531215;2000.8599398042288;945.7351941456403;984.1044649369182;1002.3384566186282;1033.7725700345911;1108.4956344863228;20089.196432142842;20655.070521826554;20823.8958805205;20852.895735521226;21005.789942100382;998.8202123617818;1032.695354870315;1052.289704449509;1093.6008356949656;1116.235378765532;11123.944380278208;11651;11769.352685602204;11967.341796201292;12032.338221397733;518673;530808.7573727866;531433;544505;551442;85699.57150214209;87623.56188219019;88981;89255;89657.55171224102;1032.4012072997643;1035.4512108582312;1054.1724746074294;1057.1912486947492;1062.8033813744482;17630.82369176343;17873.587065745956;17922.731159032362;17933;18357.816421836145;34357.48463773095;43916.341254880565;44388.334174986754;45743;45913;62301.06548401687;64623;65578;65830.34169658241;66209.66895165494;7562.470627056054;8424.326053915549;8615.052344242004;8679.305655547667;8725;7656.502327348704;12942.482300707867;13156.276404797827;13574.660633484242;13595.252261125734;11726.88273117258;11850;11939.641810745692;11987.520499179935;12261.38693065361;11317.264377815416;11501.712457188303;11619;11776.352300623548;11830.881691182978;11297.491612877277;11526.711832204262;12080.697982550506;12200.938995304967;12291.385430728607;7930.444868859125;7933.880991785012;7981.3614910808155;8075.87886181696;8100.351971842357;8787.472751634923;10191.286609937233;11034.834477482684;11270.098392128446;11767.411629418666 23:44:00 INFO - PROCESS | 30995 | |3;mootools.html;1509.675419784746;1513.1904431129344;1692.1708362902182;1793.4709260768063;1816.809235030321;7966.24320689535;8536.70121545746;8672.523011234387;9171.816563668732;9178.541072946342;8935.106489351061;8994.190522852941;9005.189532942033;9014.819703605925;9015.95492022539;2303.8387312888062;2343.1798870395396;2345.0854166874933;2345.2143531916827;2349.142562964514;2296.2766728480474;2313.768623137681;2333.311673056444;2340.134150364359;2340.32130682102;2316.536692661466;2325.2094287942095;2332.5101728637005;2338.2283846330756;2355.882205889707;2275.8975846086964;2309.7921187093157;2311.7688231177;2314.90740370385;2330.755270696586;2216.3018649125634;2233.0286325448483;2241.114759669921;2242.6411774116063;2243.7083179186766;8953.731388058368;9052.592633331516;9087.909120908773;9089.045650206765;9131.2238459731;5190.480951904817;5280.313559237313;5288.894222115536;5293.788248470057;5299.894002119936;3379.2142001610027;3429.8971030869116;3479.9826000869834;3494.1614012637037;3541.1678255609913;1145.2555838704825;1165.056304393444;1165.3066425476827;1165.4638866121595;1208.5951206345885;12522.499100035988;12545.811812822723;12559.748805023939;12570.68573285666;12571.685707857378;4396.296592545177;4470.396496472999;4580.450345958507;4616.584507394351;4631.560001799824;10625.203109766799;10638.787224255471;10651.520681569347;10652;10664.520096595672;5311.893762124736;5332;5345.198220266913;5357.598180136505;5363.19552067193;4355.346697995326;4766.165920963817;4906.607471402279;4917.164082106051;4929.186684197139;3914.9804250978564;3928.3910993796007;3982.980085099556;3993.600639935983;4103.85636502721;1224.0880543994604;1227.1226073357593;1233.808759642257;1236.7031912341154;1265.2155663488695;939;945.7304668169538;999.5801763259449;1013.1287093099928;1016.974575635615;6048.60684055535;6366.904496432558;6446.871062578816;6484.902726459107;6499.28507864144;957.5020989085637;1057.5082586597268;1081.4808891732014;1118.2228351295935;1140.0252783869837;4368.148211098805;4386.780660966939;4437.445319335083;4474.843380481668;4568.748718820497;11131.833022504668;11459.140564457699;11504.137189710806;11591.24656897299;11612.88387116135;11362;11393.829092563617;11429.085673146128;11447.313161210353;11457.942710286396;7448.106227252656;7679.500832445873;7733.729319473904;7825;7849.882251766228;6107.328193898757;6183.165272688309;6285.340039295808;6407.871842563216;6447.806565803034;9958.850617240892;10186.236032297458;10211.489425528842;10312.690619281433;10424;10330.328528645614;10437.843432348673;10451.84322235152;10490.685279441628;10571.682849514527;8138.267555919995;8195.34437245007;8223.54770487629;8272.669093236203;8273.4622249556;8806.471611703319;8859.734207973772;8877.556122193735;8885.511296878734;8942.955285223532;7784.84430311402;7970.4420690553425;8032.036155661358;8098.797530061795;8136.06435259929;7890.723824666109;7924.445288829726;7984.760457186294;7987.600619968862;7994.680212791423;6971.128608923885;7169.964150179216;7232.312930271616;7241.275872412716;7252.456065795192;5365.2220428036935;5365.758540865749;5368.114261146867;5370.140777475585;5379.1393377059485;5463.890722185454;5531.612787105025;5537.667739935617;5596.944030559643;5635.126555383922 23:44:00 INFO - PROCESS | 30995 | |4;prototype.html;308.8903439279056;312.4750419295583;321.6477956637482;327.17551769540756;327.8426355349431;5144;5640.3795582486;5720.542356611471;5761.337446193684;5784.623999440033;5468.070428027235;5582.49757521823;5599.300087489064;5615.382307946133;5629.943700563003;4245.257080011002;4254.808533615995;4273.380359847836;4274.781687219143;4285.314349704048;4268.231718290722;4276.166147601219;4307.504636966742;4353.67347448941;4358.97820510897;4146.8133933972895;4293.248681480744;4299.978500107495;4310.310350343945;4349.325854492543;4297.978510107429;4299.763513006784;4327.459067616533;4327.785019052035;4338.327559228324;3788.3181027415053;3794.7042039566218;3794.753341032824;3806.809659517013;3809.257194847006;5442.809501667422;5465.398806131322;5481.835544933659;5594.706170470128;5600.663960162363;4856.615864478642;4927.581155601778;4931.186354251544;4938.654294199408;4944.653874228806;5867.325257595346;5908.291005079375;5912;5947.851303717398;5952.821415357546;3952.4268980997595;4137.358709400048;4167.333226683716;4171.416001759756;4191.371294305848;6102.833494109616;6128.40369722708;6152.815415537541;6153.784617538409;6156.692165391757;4254.787260636956;4271;4275;4292.613664770186;4304.526502084768;4086.0193553546933;4279.7218180818145;4295.248331541968;4338.479382474124;4344.739315641072;4913.778879950411;4932.818332175727;4937.1606826839525;4944.579710724557;4944.728039957837;5933.762649494059;5942.554308426886;5951.761929522857;5954.672493012839;6005.789797357072;1447.1461837515706;1487.1820498725658;1489.3744627256578;1492.8059352284351;1516.385863725193;949.4872768704822;968.162539403411;988.2390559269322;992.9751756206152;993.7813680990171;4986.276989836526;5087.913955278318;5096.847094587169;5117.5394214520875;5135.974320128375;5279.52484276417;5340.611441025284;5378.489043540935;5383.16560933056;5403.567714582824;4843.878903027453;4945.9258111128365;5004.774785134678;5042.773075211624;5059.595232381401;2805.5651374037056;2856.685764565896;2861.585070164856;2872.003957249691;2885.1771402891254;5409.513143817076;5437.34751829783;5482.342118945752;5509.972450137724;5531.419200983919;5117.309163262912;5394.514493695587;5402.243685883979;5437.302634208697;5448.618596698272;5419.376771671229;5483.506484416422;5509.741006187444;5522.603598786717;5526.397344770052;5237.502437268454;5253.212018197148;5319.521243088141;5395.784168633368;5419.856483239632;5582.441755824548;6068.2692788244585;6070.2412198475195;6074.544409169242;6089.5737298388685;6245.6252624842655;6261.154744109669;6294.779682711083;6297.1813664223355;6300.936990630218;4146.709730318848;4154.169166166839;4155.148194620036;4244.681648876285;4274.807633656431;5884.676342801187;6079.848003799763;6101.328853826164;6135.355787642412;6145;5871.7651293947765;6003.3996600339615;6003.459688628044;6007.8197654070445;6021.879562408815;5903.203067585821;5939.198208241832;5961.850953726018;5972.970135149297;6013.458788709037;5731.077150653114;5918.496927761016;5943.702814859326;5972.492338151305;5989.161517387656;6001.939980600313;6035.18524999137;6036.336003039574;6036.6679832609625;6053.364396738279;5600.963821693;5894.410558944242;5915.822525324247;5940.524758019262;5955.94519890637 23:44:00 INFO - PROCESS | 30995 | |5;yui.html;735.4594373135744;753.3257734327773;770.6955752477768;785.1520358013346;870.4864130163203;15388.15365154916;15651.826312896623;16053.357865685373;16062.357505699758;16118.113503757319;14587.34356953937;14784.6303842404;14798.778018329735;14807.925960370183;14812.25938703066;660.8546119853637;789.1319548496665;830.4726498673325;834.6035633074272;839.3578912132193;835.6114406800837;835.6197929941862;836.6235194162621;836.8451836410253;837.3092198935872;879.4020066354876;881.0484676549312;882.1839798186684;882.8101958079012;884.6328773558965;873.1617647058799;876.3427429427929;877.8068824858489;879.8768172455797;880.520116536486;634.7080343042206;638.73811737188;639.162696867101;639.7185238495048;641.3394203969918;15392.30734616945;15394.53816385499;15400.152991585459;15406.922965385213;15417.691646167126;13917.373718182705;15350.232488375537;15386.923065384713;15530;15551.766723499157;13108.86891131086;13436.462541498327;13635.181889086687;13790.379432925542;13832.170069795844;4027.3153563894207;4040.9797951010055;4621.930671039937;4625.514320996281;4676.018036212399;80930;81106;83066;83872.58063709704;84278.57860710718;11522.827157592643;11539.538418463168;11599.478023488964;11842.052635789116;11846.466908989116;21320.36038918835;21411.250606228707;21426.464338391666;21609.135634574755;21717.67423488649;8410.957945210235;8493.830123397622;8615.956920215358;8667;8842;4439.467263928349;4657.876336030339;4698.083873644675;4868.318435419044;5015.799368025311;3331.267121233325;3423.8116903570044;3441.6730410610953;3496.30073985204;3500.7024402925526;637.1907677249867;637.4135795068548;646.2600322630561;670.9228438729608;671.378974448633;567.821136342051;664.2858926653867;665.4144352969356;678.9660516974131;695.9930400696029;9168;9265.397749146285;9985.950070249748;10079.294449388472;10094.444805535766;569.7037540478927;608;627.9183706118175;636.7962252079383;637.8118455055769;4531.637469002472;4760.119377915097;4793.904121917542;4805.975970120127;4823.855284341405;69147.30852691409;70377.64811175912;70393.29606703867;70419.64790176017;72298;107030;107841.46079269554;108865;109604;110397.44801276103;93789.53105234567;95105;97200.51399742956;99270.50364748275;100395;8744.562771861509;8779.410074028305;8834.204921557091;8859.316729821314;9114;54828.72585637046;56415;57253;57425;57496.425035749104;79625;82079;83021.16978830376;85106.57446712727;85242;12196.329201893981;12305.815412768994;12324.876751232372;12366.690832729253;12657.620271391874;13000.934995324962;13001;13041.087123901236;13054.282014489294;13265.734685306434;12092.093093018235;12377.566785162477;12463.688407789878;12564.492260928748;12604.432800523815;11681.357525336189;11751;11801.881981180079;11814.468348924147;11959.581414650445;12362.814557781461;12421.006319494238;13775.38010789537;14093.577192684235;14584.48954286595;11743.530258789895;12061.75876482483;12215.389230538616;12315.753684926072;12520;11878.46546905374;12266.632001039983;12267.938660306641;12362.134650574733;12533.122681412213 23:44:00 INFO - PROCESS | 30995 | __end_tp_report 23:44:00 INFO - PROCESS | 30995 | __start_cc_report 23:44:00 INFO - PROCESS | 30995 | _x_x_mozilla_cycle_collect,365 23:44:00 INFO - PROCESS | 30995 | __end_cc_report 23:44:00 INFO - PROCESS | 30995 | __startTimestamp1468910640685__endTimestamp 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | ------- Summary: start ------- 23:44:00 INFO - PROCESS | 30995 | Number of tests: 6 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | [#0] dojo.html Cycles:165 Average:5345.00 Median:5578.11 stddev:603.04 (10.8%) stddev-sans-first:577.37 23:44:00 INFO - PROCESS | 30995 | Values: 3049.3 3071.4 3075.1 3083.6 3096.7 5332.9 5354.9 5368.2 5377.7 5403.4 5237.1 5297.8 5299.7 5328.6 5353.9 4839.9 4865.5 4909.6 4950.6 4984.5 4924.5 4949.3 5037.0 5050.1 5086.6 4880.2 4984.8 5012.5 5013.9 5024.0 4935.3 4937.5 4938.9 4948.6 4989.7 4890.2 4892.1 4894.0 4922.0 4944.7 5222.4 5229.4 5287.7 5419.3 5457.3 5679.2 5689.6 5696.1 5710.6 5756.0 5739.8 5754.6 5755.6 5758.8 5759.7 5273.2 5340.1 5350.9 5368.9 5390.4 5891.5 5901.3 5914.3 5919.4 5935.1 5659.4 5670.8 5679.5 5680.9 5681.4 5520.6 5650.2 5674.6 5714.3 5733.3 5672.8 5686.9 5689.6 5689.7 5690.0 5595.4 5680.9 5715.3 5717.6 5736.5 4294.6 4339.9 4344.5 4352.2 4397.0 3901.5 3933.1 3938.8 3943.5 3968.0 5302.6 5447.5 5474.6 5477.2 5520.9 5664.6 5709.9 5746.9 5750.9 5768.4 5449.6 5451.8 5468.3 5473.6 5481.6 4946.7 4976.1 4977.2 5015.9 5026.6 5949.2 5949.6 5963.4 5974.2 5987.2 5577.8 5696.5 5781.0 5797.0 5805.2 5906.3 5908.9 5962.1 5967.5 6038.8 5609.7 5674.1 5677.3 5688.9 5713.3 5564.1 5695.1 5696.1 5786.7 5806.9 5650.7 5666.1 5674.3 5684.0 5688.3 5656.3 5659.2 5659.7 5662.2 5677.1 5465.7 5558.3 5578.1 5607.7 5645.9 5613.1 5658.8 5709.3 5718.1 5754.7 5565.3 5577.6 5586.6 5594.4 5615.7 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | [#1] ext.html Cycles:180 Average:62116.79 Median:42699.68 stddev:129144.37 (302.4%) stddev-sans-first:129423.92 23:44:00 INFO - PROCESS | 30995 | Values: 547.6 587.2 593.5 602.4 607.7 40436.4 44499.1 44741.6 44929.0 44984.1 43495.6 43634.6 43641.8 43857.3 44198.3 8805.6 9009.9 9021.5 9029.7 9060.9 8906.6 8922.6 8934.9 8953.6 8990.1 9051.4 9104.1 9106.8 9109.0 9116.9 8941.6 9018.4 9029.4 9049.9 9083.1 8911.0 8924.6 8938.8 8965.5 8980.2 41896.4 42487.2 42695.8 42747.6 42781.6 3647.9 3672.9 3796.3 3866.5 4232.8 33125.7 33183.2 33231.7 33405.0 33439.0 4277.9 4387.4 4416.7 4455.6 4521.2 361289.0 361856.0 362091.0 362646.0 363497.0 34921.3 36447.3 58766.7 59704.4 59802.4 37557.0 37604.4 37731.8 37840.0 37874.0 15856.5 15888.0 15924.4 15935.8 15946.4 13289.9 13364.7 13402.0 13437.7 13454.7 8409.9 8416.4 8465.3 8525.8 8596.8 3174.3 3294.2 3306.0 3313.6 3348.1 940.5 1031.6 1090.8 1091.6 1114.7 31419.2 31458.8 31647.2 31697.2 31943.8 1116.5 1144.8 1155.7 1217.2 1231.9 16102.2 16451.8 16464.0 16780.2 16821.0 618567.0 621166.0 628633.0 629490.0 631006.0 61595.0 62098.4 62131.7 62139.4 62291.0 1331.2 1336.9 1347.9 1358.2 1362.2 29969.6 30352.6 30463.0 30832.2 31370.0 51903.5 52831.2 52916.5 53015.0 53023.7 422990.0 424895.0 425208.0 426303.0 427447.0 28652.9 28794.9 29362.4 29442.4 29549.4 50474.2 51128.0 51427.7 51598.1 51850.5 42643.4 43252.4 43945.3 44048.0 45061.0 42901.8 43109.8 43168.4 43577.3 45080.3 41854.8 42703.6 42919.6 43130.8 45481.5 37144.8 39184.2 39371.4 40182.0 40443.6 28971.0 29312.3 29323.4 29437.0 29630.7 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | [#2] jquery.html Cycles:180 Average:30756.62 Median:2545.49 stddev:88083.57 (3460.4%) stddev-sans-first:88301.16 23:44:00 INFO - PROCESS | 30995 | Values: 391.2 392.3 398.9 400.1 415.3 14173.4 18809.2 19040.1 20662.9 20891.7 18511.6 18809.3 19280.1 20606.8 20666.5 5716.7 5804.4 5871.5 5882.5 5883.2 5661.1 5707.8 5798.9 5831.6 5837.6 5724.4 5734.7 5885.6 5897.8 5904.9 5800.6 5831.8 5836.9 5844.5 5863.6 5028.4 5074.6 5094.8 5113.9 5117.2 23852.5 24157.0 24221.3 24314.1 24869.3 2528.4 2562.6 2618.0 2638.2 3069.4 14750.9 14859.8 15186.9 15661.6 15666.4 1972.6 1981.2 1993.7 2032.3 2094.7 76627.0 85020.0 86071.6 87128.6 89237.0 10487.2 10761.5 10788.6 10908.7 11153.4 15275.4 15285.9 15343.2 15354.2 15475.8 8297.6 8422.3 8472.0 8531.2 8648.9 8161.0 8199.5 8223.3 8470.7 8538.7 6608.1 6703.8 6727.7 6799.8 6957.4 1908.7 1959.7 1980.8 1982.2 2000.9 945.7 984.1 1002.3 1033.8 1108.5 20089.2 20655.1 20823.9 20852.9 21005.8 998.8 1032.7 1052.3 1093.6 1116.2 11123.9 11651.0 11769.4 11967.3 12032.3 518673.0 530808.8 531433.0 544505.0 551442.0 85699.6 87623.6 88981.0 89255.0 89657.6 1032.4 1035.5 1054.2 1057.2 1062.8 17630.8 17873.6 17922.7 17933.0 18357.8 34357.5 43916.3 44388.3 45743.0 45913.0 62301.1 64623.0 65578.0 65830.3 66209.7 7562.5 8424.3 8615.1 8679.3 8725.0 7656.5 12942.5 13156.3 13574.7 13595.3 11726.9 11850.0 11939.6 11987.5 12261.4 11317.3 11501.7 11619.0 11776.4 11830.9 11297.5 11526.7 12080.7 12200.9 12291.4 7930.4 7933.9 7981.4 8075.9 8100.4 8787.5 10191.3 11034.8 11270.1 11767.4 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | [#3] mootools.html Cycles:180 Average:5958.86 Median:4472.62 stddev:3398.61 (76.0%) stddev-sans-first:3391.70 23:44:00 INFO - PROCESS | 30995 | Values: 1509.7 1513.2 1692.2 1793.5 1816.8 7966.2 8536.7 8672.5 9171.8 9178.5 8935.1 8994.2 9005.2 9014.8 9016.0 2303.8 2343.2 2345.1 2345.2 2349.1 2296.3 2313.8 2333.3 2340.1 2340.3 2316.5 2325.2 2332.5 2338.2 2355.9 2275.9 2309.8 2311.8 2314.9 2330.8 2216.3 2233.0 2241.1 2242.6 2243.7 8953.7 9052.6 9087.9 9089.0 9131.2 5190.5 5280.3 5288.9 5293.8 5299.9 3379.2 3429.9 3480.0 3494.2 3541.2 1145.3 1165.1 1165.3 1165.5 1208.6 12522.5 12545.8 12559.7 12570.7 12571.7 4396.3 4470.4 4580.5 4616.6 4631.6 10625.2 10638.8 10651.5 10652.0 10664.5 5311.9 5332.0 5345.2 5357.6 5363.2 4355.3 4766.2 4906.6 4917.2 4929.2 3915.0 3928.4 3983.0 3993.6 4103.9 1224.1 1227.1 1233.8 1236.7 1265.2 939.0 945.7 999.6 1013.1 1017.0 6048.6 6366.9 6446.9 6484.9 6499.3 957.5 1057.5 1081.5 1118.2 1140.0 4368.1 4386.8 4437.4 4474.8 4568.7 11131.8 11459.1 11504.1 11591.2 11612.9 11362.0 11393.8 11429.1 11447.3 11457.9 7448.1 7679.5 7733.7 7825.0 7849.9 6107.3 6183.2 6285.3 6407.9 6447.8 9958.9 10186.2 10211.5 10312.7 10424.0 10330.3 10437.8 10451.8 10490.7 10571.7 8138.3 8195.3 8223.5 8272.7 8273.5 8806.5 8859.7 8877.6 8885.5 8943.0 7784.8 7970.4 8032.0 8098.8 8136.1 7890.7 7924.4 7984.8 7987.6 7994.7 6971.1 7170.0 7232.3 7241.3 7252.5 5365.2 5365.8 5368.1 5370.1 5379.1 5463.9 5531.6 5537.7 5596.9 5635.1 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | [#4] prototype.html Cycles:180 Average:4811.23 Median:5399.01 stddev:1427.84 (26.4%) stddev-sans-first:1391.28 23:44:00 INFO - PROCESS | 30995 | Values: 308.9 312.5 321.6 327.2 327.8 5144.0 5640.4 5720.5 5761.3 5784.6 5468.1 5582.5 5599.3 5615.4 5629.9 4245.3 4254.8 4273.4 4274.8 4285.3 4268.2 4276.2 4307.5 4353.7 4359.0 4146.8 4293.2 4300.0 4310.3 4349.3 4298.0 4299.8 4327.5 4327.8 4338.3 3788.3 3794.7 3794.8 3806.8 3809.3 5442.8 5465.4 5481.8 5594.7 5600.7 4856.6 4927.6 4931.2 4938.7 4944.7 5867.3 5908.3 5912.0 5947.9 5952.8 3952.4 4137.4 4167.3 4171.4 4191.4 6102.8 6128.4 6152.8 6153.8 6156.7 4254.8 4271.0 4275.0 4292.6 4304.5 4086.0 4279.7 4295.2 4338.5 4344.7 4913.8 4932.8 4937.2 4944.6 4944.7 5933.8 5942.6 5951.8 5954.7 6005.8 1447.1 1487.2 1489.4 1492.8 1516.4 949.5 968.2 988.2 993.0 993.8 4986.3 5087.9 5096.8 5117.5 5136.0 5279.5 5340.6 5378.5 5383.2 5403.6 4843.9 4945.9 5004.8 5042.8 5059.6 2805.6 2856.7 2861.6 2872.0 2885.2 5409.5 5437.3 5482.3 5510.0 5531.4 5117.3 5394.5 5402.2 5437.3 5448.6 5419.4 5483.5 5509.7 5522.6 5526.4 5237.5 5253.2 5319.5 5395.8 5419.9 5582.4 6068.3 6070.2 6074.5 6089.6 6245.6 6261.2 6294.8 6297.2 6300.9 4146.7 4154.2 4155.1 4244.7 4274.8 5884.7 6079.8 6101.3 6135.4 6145.0 5871.8 6003.4 6003.5 6007.8 6021.9 5903.2 5939.2 5961.9 5973.0 6013.5 5731.1 5918.5 5943.7 5972.5 5989.2 6001.9 6035.2 6036.3 6036.7 6053.4 5601.0 5894.4 5915.8 5940.5 5955.9 23:44:00 INFO - PROCESS | 30995 | 23:44:00 INFO - PROCESS | 30995 | [#5] yui.html Cycles:180 Average:20706.95 Median:4687.05 stddev:29378.69 (626.8%) stddev-sans-first:29422.83 23:44:00 INFO - PROCESS | 30995 | Values: 735.5 753.3 770.7 785.2 870.5 15388.2 15651.8 16053.4 16062.4 16118.1 14587.3 14784.6 14798.8 14807.9 14812.3 660.9 789.1 830.5 834.6 839.4 835.6 835.6 836.6 836.8 837.3 879.4 881.0 882.2 882.8 884.6 873.2 876.3 877.8 879.9 880.5 634.7 638.7 639.2 639.7 641.3 15392.3 15394.5 15400.2 15406.9 15417.7 13917.4 15350.2 15386.9 15530.0 15551.8 13108.9 13436.5 13635.2 13790.4 13832.2 4027.3 4041.0 4621.9 4625.5 4676.0 80930.0 81106.0 83066.0 83872.6 84278.6 11522.8 11539.5 11599.5 11842.1 11846.5 21320.4 21411.3 21426.5 21609.1 21717.7 8411.0 8493.8 8616.0 8667.0 8842.0 4439.5 4657.9 4698.1 4868.3 5015.8 3331.3 3423.8 3441.7 3496.3 3500.7 637.2 637.4 646.3 670.9 671.4 567.8 664.3 665.4 679.0 696.0 9168.0 9265.4 9986.0 10079.3 10094.4 569.7 608.0 627.9 636.8 637.8 4531.6 4760.1 4793.9 4806.0 4823.9 69147.3 70377.6 70393.3 70419.6 72298.0 107030.0 107841.5 108865.0 109604.0 110397.4 93789.5 95105.0 97200.5 99270.5 100395.0 8744.6 8779.4 8834.2 8859.3 9114.0 54828.7 56415.0 57253.0 57425.0 57496.4 79625.0 82079.0 83021.2 85106.6 85242.0 12196.3 12305.8 12324.9 12366.7 12657.6 13000.9 13001.0 13041.1 13054.3 13265.7 12092.1 12377.6 12463.7 12564.5 12604.4 11681.4 11751.0 11801.9 11814.5 11959.6 12362.8 12421.0 13775.4 14093.6 14584.5 11743.5 12061.8 12215.4 12315.8 12520.0 11878.5 12266.6 12267.9 12362.1 12533.1 23:44:00 INFO - PROCESS | 30995 | -------- Summary: end -------- 23:44:00 INFO - PROCESS | 30995 | 23:44:01 INFO - TEST-INFO | 30995: exit 0 23:44:01 INFO - TEST-OK | dromaeo_css | took 1110150ms 23:44:01 INFO - TEST-START | kraken 23:44:01 INFO - operating with platform_type : linux_ 23:44:01 INFO - Initialising browser for kraken test... 23:44:01 INFO - TEST-INFO | started process 31247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsZfeJY/profile http://localhost:52925/getInfo.html) 23:44:05 INFO - PROCESS | 31247 | __metrics Screen width/height:1600/1200 23:44:05 INFO - PROCESS | 31247 | colorDepth:24 23:44:05 INFO - PROCESS | 31247 | Browser inner width/height: 1024/697 23:44:05 INFO - PROCESS | 31247 | __metrics 23:44:05 ERROR - PROCESS | 31247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 23:44:06 INFO - TEST-INFO | 31247: exit 0 23:44:06 INFO - Browser initialized. 23:44:06 INFO - Running cycle 1/1 for kraken test... 23:44:06 INFO - TEST-INFO | started process 31368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsZfeJY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:44:18 INFO - PROCESS | 31368 | RSS: Main: 168001536 23:44:18 INFO - PROCESS | 31368 | 23:44:20 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52925/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:21 INFO - PROCESS | 31368 | RSS: Main: 172810240 23:44:21 INFO - PROCESS | 31368 | 23:44:24 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52925/tests/kraken/driver.html?testName=audio-dft) 23:44:25 INFO - PROCESS | 31368 | RSS: Main: 172457984 23:44:25 INFO - PROCESS | 31368 | 23:44:27 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52925/tests/kraken/driver.html?testName=audio-fft) 23:44:28 INFO - PROCESS | 31368 | RSS: Main: 167641088 23:44:28 INFO - PROCESS | 31368 | 23:44:30 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52925/tests/kraken/driver.html?testName=audio-oscillator) 23:44:31 INFO - PROCESS | 31368 | RSS: Main: 168525824 23:44:31 INFO - PROCESS | 31368 | 23:44:33 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:44:33 INFO - PROCESS | 31368 | RSS: Main: 168534016 23:44:33 INFO - PROCESS | 31368 | 23:44:37 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52925/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:37 INFO - PROCESS | 31368 | RSS: Main: 168796160 23:44:37 INFO - PROCESS | 31368 | 23:44:41 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52925/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:41 INFO - PROCESS | 31368 | RSS: Main: 169672704 23:44:41 INFO - PROCESS | 31368 | 23:44:44 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52925/tests/kraken/driver.html?testName=json-parse-financial) 23:44:45 INFO - PROCESS | 31368 | RSS: Main: 169656320 23:44:45 INFO - PROCESS | 31368 | 23:44:46 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:47 INFO - PROCESS | 31368 | RSS: Main: 169566208 23:44:47 INFO - PROCESS | 31368 | 23:44:49 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:49 INFO - PROCESS | 31368 | RSS: Main: 169336832 23:44:49 INFO - PROCESS | 31368 | 23:44:51 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:52 INFO - PROCESS | 31368 | RSS: Main: 169541632 23:44:52 INFO - PROCESS | 31368 | 23:44:55 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:55 INFO - PROCESS | 31368 | RSS: Main: 169893888 23:44:55 INFO - PROCESS | 31368 | 23:44:58 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:59 INFO - PROCESS | 31368 | RSS: Main: 170344448 23:44:59 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | Cycle 1(1): loaded http://localhost:52925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52925/tests/kraken/driver.html?testName=ai-astar) 23:45:00 INFO - PROCESS | 31368 | RSS: Main: 170459136 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | __start_tp_report 23:45:00 INFO - PROCESS | 31368 | _x_x_mozilla_page_load 23:45:00 INFO - PROCESS | 31368 | _x_x_mozilla_page_load_details 23:45:00 INFO - PROCESS | 31368 | |i|pagename|runs| 23:45:00 INFO - PROCESS | 31368 | |0;ai-astar;106;112;107;113;113;113;115;113;113;112 23:45:00 INFO - PROCESS | 31368 | |1;audio-beat-detection;144;120;146;166;120;146;147;120;182;119 23:45:00 INFO - PROCESS | 31368 | |2;audio-dft;162;163;162;161;163;164;166;168;161;164 23:45:00 INFO - PROCESS | 31368 | |3;audio-fft;75;76;77;147;75;84;75;76;159;78 23:45:00 INFO - PROCESS | 31368 | |4;audio-oscillator;84;84;149;84;85;85;149;84;83;141 23:45:00 INFO - PROCESS | 31368 | |5;imaging-gaussian-blur;118;117;118;117;117;117;117;118;118;118 23:45:00 INFO - PROCESS | 31368 | |6;imaging-darkroom;148;146;148;148;147;149;146;147;148;148 23:45:00 INFO - PROCESS | 31368 | |7;imaging-desaturate;96;95;96;95;95;96;95;95;95;96 23:45:00 INFO - PROCESS | 31368 | |8;json-parse-financial;52;54;53;53;55;53;51;52;51;53 23:45:00 INFO - PROCESS | 31368 | |9;json-stringify-tinderbox;60;61;60;60;60;59;60;61;60;61 23:45:00 INFO - PROCESS | 31368 | |10;stanford-crypto-aes;76;75;76;76;76;75;76;77;79;76 23:45:00 INFO - PROCESS | 31368 | |11;stanford-crypto-ccm;120;132;121;120;121;127;120;133;166;124 23:45:00 INFO - PROCESS | 31368 | |12;stanford-crypto-pbkdf2;155;167;163;161;161;157;158;154;157;159 23:45:00 INFO - PROCESS | 31368 | |13;stanford-crypto-sha256-iterative;67;65;64;65;62;65;63;62;63;61 23:45:00 INFO - PROCESS | 31368 | __end_tp_report 23:45:00 INFO - PROCESS | 31368 | __start_cc_report 23:45:00 INFO - PROCESS | 31368 | _x_x_mozilla_cycle_collect,905 23:45:00 INFO - PROCESS | 31368 | __end_cc_report 23:45:00 INFO - PROCESS | 31368 | __startTimestamp1468910700914__endTimestamp 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | ------- Summary: start ------- 23:45:00 INFO - PROCESS | 31368 | Number of tests: 14 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:2.87 (2.5%) stddev-sans-first:2.18 23:45:00 INFO - PROCESS | 31368 | Values: 106.0 112.0 107.0 113.0 113.0 113.0 115.0 113.0 113.0 112.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:146.00 stddev:21.62 (14.8%) stddev-sans-first:22.91 23:45:00 INFO - PROCESS | 31368 | Values: 144.0 120.0 146.0 166.0 120.0 146.0 147.0 120.0 182.0 119.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.22 (1.4%) stddev-sans-first:2.30 23:45:00 INFO - PROCESS | 31368 | Values: 162.0 163.0 162.0 161.0 163.0 164.0 166.0 168.0 161.0 164.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:32.28 (42.5%) stddev-sans-first:33.63 23:45:00 INFO - PROCESS | 31368 | Values: 75.0 76.0 77.0 147.0 75.0 84.0 75.0 76.0 159.0 78.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.00 stddev:30.12 (35.9%) stddev-sans-first:31.17 23:45:00 INFO - PROCESS | 31368 | Values: 84.0 84.0 149.0 84.0 85.0 85.0 149.0 84.0 83.0 141.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 23:45:00 INFO - PROCESS | 31368 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 23:45:00 INFO - PROCESS | 31368 | Values: 148.0 146.0 148.0 148.0 147.0 149.0 146.0 147.0 148.0 148.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:45:00 INFO - PROCESS | 31368 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.25 (2.4%) stddev-sans-first:1.30 23:45:00 INFO - PROCESS | 31368 | Values: 52.0 54.0 53.0 53.0 55.0 53.0 51.0 52.0 51.0 53.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 23:45:00 INFO - PROCESS | 31368 | Values: 60.0 61.0 60.0 60.0 60.0 59.0 60.0 61.0 60.0 61.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:1.14 (1.5%) stddev-sans-first:1.20 23:45:00 INFO - PROCESS | 31368 | Values: 76.0 75.0 76.0 76.0 76.0 75.0 76.0 77.0 79.0 76.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:125.50 stddev:14.10 (11.2%) stddev-sans-first:14.63 23:45:00 INFO - PROCESS | 31368 | Values: 120.0 132.0 121.0 120.0 121.0 127.0 120.0 133.0 166.0 124.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.00 stddev:3.91 (2.4%) stddev-sans-first:3.84 23:45:00 INFO - PROCESS | 31368 | Values: 155.0 167.0 163.0 161.0 161.0 157.0 158.0 154.0 157.0 159.0 23:45:00 INFO - PROCESS | 31368 | 23:45:00 INFO - PROCESS | 31368 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.50 stddev:1.83 (2.8%) stddev-sans-first:1.50 23:45:00 INFO - PROCESS | 31368 | Values: 67.0 65.0 64.0 65.0 62.0 65.0 63.0 62.0 63.0 61.0 23:45:00 INFO - PROCESS | 31368 | -------- Summary: end -------- 23:45:00 INFO - PROCESS | 31368 | 23:45:01 INFO - TEST-INFO | 31368: exit 0 23:45:01 INFO - TEST-OK | kraken | took 60462ms 23:45:01 INFO - SUITE-END | took 1170s 23:45:02 INFO - Completed test suite (00:19:30) 23:45:02 INFO - javascript benchmark 23:45:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7323.0445923676525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.3139043715164, 3071.4317851197543, 3075.1082186166004, 3083.5528848316994, 3096.7367773739215, 5332.8534365111545, 5354.892902141954, 5368.221607866862, 5377.704226267554, 5403.351597808259, 5237.10969135247, 5297.788088476456, 5299.735013249341, 5328.573714102872, 5353.866153346168, 4839.927401088987, 4865.537773911473, 4909.582685471739, 4950.603951683856, 4984.451710311862, 4924.507549245082, 4949.331840201581, 5036.974815125919, 5050.065737838511, 5086.618503612225, 4880.219164933594, 4984.750762461862, 5012.498750124995, 5013.924791128136, 5023.995200959805, 4935.333729946447, 4937.506249375069, 4938.851834444972, 4948.604111671094, 4989.700617962933, 4890.193118135503, 4892.119418504668, 4893.975530122327, 4922.0, 4944.678595891256, 5222.399424066243, 5229.37247530295, 5287.68273903567, 5419.268398766156, 5457.263269458612, 5679.204911312419, 5689.630174038715, 5696.060150075233, 5710.600257981943, 5756.0, 5739.827805165852, 5754.625949313281, 5755.625884317506, 5758.769649214027, 5759.740811663485, 5273.182656688219, 5340.092184328673, 5350.91973620396, 5368.8657783554945, 5390.434004429479, 5891.46976772084, 5901.291844978544, 5914.260717410324, 5919.4080591940465, 5935.080062590306, 5659.377468478464, 5670.829875103754, 5679.488846003879, 5680.914786278209, 5681.403452637496, 5520.585956053312, 5650.180723795027, 5674.631148975386, 5714.314282286069, 5733.254676891977, 5672.801451949162, 5686.886262274814, 5689.573282003867, 5689.68706721126, 5689.971550142222, 5595.412481689364, 5680.857978550569, 5715.314162300468, 5717.571182161355, 5736.4550367715, 4294.613484786384, 4339.891502712458, 4344.54382289855, 4352.173087113439, 4397.0, 3901.51231096113, 3933.095388060705, 3938.822752976123, 3943.526776786804, 3968.027833180889, 5302.575793936476, 5447.53695935842, 5474.562035037187, 5477.1510415885605, 5520.861978450571, 5664.631798933056, 5709.857253568694, 5746.856328591819, 5750.88498230033, 5768.394318596487, 5449.591280653967, 5451.781928722886, 5468.343798744097, 5473.562115030788, 5481.561475081984, 4946.727929963815, 4976.0794253063295, 4977.1538838397555, 5015.899682006339, 5026.623003274769, 5949.196858424144, 5949.613275137102, 5963.4334738199805, 5974.193483879708, 5987.221661184019, 5577.77688892456, 5696.458836410535, 5780.959427303126, 5797.0, 5805.245318108618, 5906.26171728534, 5908.881822363614, 5962.105684147413, 5967.46292833647, 6038.849028774316, 5609.747561359667, 5674.120511320752, 5677.290338707661, 5688.886222275614, 5713.257276554022, 5564.054110801093, 5695.060315047971, 5696.088625819849, 5786.681732504752, 5806.883862322646, 5650.689212093374, 5666.093425051972, 5674.319081710221, 5684.0, 5688.345840228427, 5656.264685590847, 5659.207710920557, 5659.745311460912, 5662.235598194191, 5677.063284558001, 5465.726713664221, 5558.305211848519, 5578.107502799533, 5607.74765135578, 5645.943540564706, 5613.101903695389, 5658.830235092789, 5709.25779648643, 5718.085106382959, 5754.6547207167705, 5565.30433695788, 5577.581681373832, 5586.636868603528, 5594.440555944373, 5615.747291371817], "value": 5304.030471185737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.5688605736211, 587.1926101610286, 593.4718100890209, 602.4337123104283, 607.7325976570306, 40436.393454098215, 44499.11001779963, 44741.55258447414, 44929.0, 44984.10031799362, 43495.56504434955, 43634.56365436345, 43641.781791091, 43857.34213986785, 44198.33702494465, 8805.603747831346, 9009.909900901006, 9021.503817290046, 9029.729108126767, 9060.864087038699, 8906.554672266393, 8922.643094276222, 8934.910650893506, 8953.59708813105, 8990.145936136056, 9051.411658242194, 9104.089591040876, 9106.77233069172, 9109.0, 9116.908830911672, 8941.642334306653, 9018.413803102778, 9029.41308814925, 9049.864252036225, 9083.137101975302, 8911.0, 8924.598393072327, 8938.776530586721, 8965.506897120657, 8980.236679882219, 41896.37155442671, 42487.150256994995, 42695.78652106751, 42747.57252427467, 42781.57218427807, 3647.8905632831056, 3672.8530858765616, 3796.2976849282973, 3866.478025466582, 4232.78836058199, 33125.6687433125, 33183.170420739436, 33231.667683323096, 33405.0, 33439.0, 4277.935830962538, 4387.3857659927635, 4416.690831641787, 4455.621272191867, 4521.186186486431, 361289.0, 361856.0, 362091.0, 362645.9999999974, 363497.0, 34921.301573968376, 36447.27105457876, 58766.706166468895, 59704.402955970756, 59802.40197597969, 37557.0, 37604.43593346102, 37731.81134094367, 37840.0, 37874.0, 15856.52430427089, 15888.046717197005, 15924.363025479082, 15935.840641593668, 15946.441874534336, 13289.93355033238, 13364.73270534584, 13402.0, 13437.664058398619, 13454.730905382034, 8409.873851892227, 8416.368772342099, 8465.280451161598, 8525.786855328543, 8596.785080372916, 3174.3175217328385, 3294.2423242653845, 3305.9834700826823, 3313.618933822593, 3348.096014076186, 940.4780346907395, 1031.5970280418624, 1090.7705175221117, 1091.6015654286127, 1114.6711720042445, 31419.214519637193, 31458.842705786323, 31647.20881977969, 31697.20756981094, 31943.840280798446, 1116.5031560955458, 1144.822552504363, 1155.6764106050318, 1217.2027322104036, 1231.876812318761, 16102.19489025544, 16451.83548164527, 16464.0, 16780.160991950353, 16821.0, 618567.0, 621166.0, 628633.0, 629490.0, 631006.0, 61595.0, 62098.379016210165, 62131.689341553, 62139.37860621426, 62291.0, 1331.1613683379603, 1336.933153342329, 1347.905646604748, 1358.2122369025942, 1362.1826903857607, 29969.550456743604, 30352.571794255964, 30463.0, 30832.229194270323, 31370.0, 51903.480965191375, 52831.20753188782, 52916.470835291155, 53015.0, 53023.73488132535, 422990.0, 424895.0, 425208.0, 426303.0, 427447.0, 28652.85673571619, 28794.85602571974, 29362.412751745273, 29442.411151777273, 29549.409011820073, 50474.242886356, 51128.0, 51427.74286128546, 51598.09818067278, 51850.48149518456, 42643.36034959416, 43252.35121473118, 43945.34081988837, 44048.0, 45061.0, 42901.78549107235, 43109.78445107755, 43168.35247471353, 43577.346339804295, 45080.323795142445, 41854.79072604617, 42703.57296426996, 42919.57080429281, 43130.78434607807, 45481.54518454773, 37144.814275928446, 39184.21631567409, 39371.409428858016, 40182.0, 40443.59556404516, 28971.0, 29312.26719332034, 29323.41353172967, 29437.0, 29630.703692962794], "value": 19363.769945410222, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1999960081633, 392.2625464127441, 398.874354578308, 400.1077596958782, 415.279490084703, 14173.433062677506, 18809.24763009478, 19040.09599040097, 20662.89668551657, 20891.686624700622, 18511.629767404676, 18809.341673041446, 19280.132394042266, 20606.79393206071, 20666.48333791656, 5716.742746576404, 5804.419558044204, 5871.471567558919, 5882.529397648178, 5883.17635531026, 5661.094224923992, 5707.800226992056, 5798.884022319551, 5831.620944638585, 5837.620554663955, 5724.427557244284, 5734.684592347419, 5885.617434866741, 5897.764089436418, 5904.88190236195, 5800.593958422912, 5831.766729330843, 5836.854078648046, 5844.503217226541, 5863.589548731569, 5028.371453568304, 5074.644774865761, 5094.821681241176, 5113.872153196163, 5117.2068329409, 23852.52294954091, 24157.0, 24221.273361799173, 24314.149004784747, 24869.25392238236, 2528.40582463121, 2562.581918398072, 2618.0, 2638.1689767723296, 3069.3554353585773, 14750.852491475056, 14859.777103343458, 15186.924065379713, 15661.608459788482, 15666.373345066298, 1972.6350625134396, 1981.2471260920902, 1993.7408136942104, 2032.2886989553538, 2094.7276854008883, 76627.0, 85020.0, 86071.56964215139, 87128.5643571778, 89237.0, 10487.161027117812, 10761.46192690378, 10788.622398216181, 10908.727281817859, 11153.38656373891, 15275.38898444072, 15285.859979602865, 15343.232838358037, 15354.232288385536, 15475.845241547666, 8297.58512074406, 8422.326213902874, 8472.04048882854, 8531.189536993976, 8648.870266946002, 8160.959195203986, 8199.467034642728, 8223.259906608433, 8470.66117355299, 8538.743837684879, 6608.107905432801, 6703.832404189837, 6727.697253623599, 6799.830004249933, 6957.408620267232, 1908.675525160726, 1959.6864501679663, 1980.7623085229577, 1982.2071171531215, 2000.8599398042288, 945.7351941456403, 984.1044649369182, 1002.3384566186282, 1033.7725700345911, 1108.4956344863228, 20089.196432142842, 20655.070521826554, 20823.8958805205, 20852.895735521226, 21005.789942100382, 998.8202123617818, 1032.695354870315, 1052.289704449509, 1093.6008356949656, 1116.235378765532, 11123.944380278208, 11651.0, 11769.352685602204, 11967.341796201292, 12032.338221397733, 518673.0, 530808.7573727866, 531433.0, 544505.0, 551442.0, 85699.57150214209, 87623.56188219019, 88981.0, 89255.0, 89657.55171224102, 1032.4012072997643, 1035.4512108582312, 1054.1724746074294, 1057.1912486947492, 1062.8033813744482, 17630.82369176343, 17873.587065745956, 17922.731159032362, 17933.0, 18357.816421836145, 34357.48463773095, 43916.341254880565, 44388.334174986754, 45743.0, 45913.0, 62301.06548401687, 64623.0, 65578.0, 65830.34169658241, 66209.66895165494, 7562.470627056054, 8424.326053915549, 8615.052344242004, 8679.305655547667, 8725.0, 7656.502327348704, 12942.482300707867, 13156.276404797827, 13574.660633484242, 13595.252261125734, 11726.88273117258, 11850.0, 11939.641810745692, 11987.520499179935, 12261.38693065361, 11317.264377815416, 11501.712457188303, 11619.0, 11776.352300623548, 11830.881691182978, 11297.491612877277, 11526.711832204262, 12080.697982550506, 12200.938995304967, 12291.385430728607, 7930.444868859125, 7933.880991785012, 7981.3614910808155, 8075.87886181696, 8100.351971842357, 8787.472751634923, 10191.286609937233, 11034.834477482684, 11270.098392128446, 11767.411629418666], "value": 9573.666516877009, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.675419784746, 1513.1904431129344, 1692.1708362902182, 1793.4709260768063, 1816.809235030321, 7966.24320689535, 8536.70121545746, 8672.523011234387, 9171.816563668732, 9178.541072946342, 8935.106489351061, 8994.190522852941, 9005.189532942033, 9014.819703605925, 9015.95492022539, 2303.8387312888062, 2343.1798870395396, 2345.0854166874933, 2345.2143531916827, 2349.142562964514, 2296.2766728480474, 2313.768623137681, 2333.311673056444, 2340.134150364359, 2340.32130682102, 2316.536692661466, 2325.2094287942095, 2332.5101728637005, 2338.2283846330756, 2355.882205889707, 2275.8975846086964, 2309.7921187093157, 2311.7688231177, 2314.90740370385, 2330.755270696586, 2216.3018649125634, 2233.0286325448483, 2241.114759669921, 2242.6411774116063, 2243.7083179186766, 8953.731388058368, 9052.592633331516, 9087.909120908773, 9089.045650206765, 9131.2238459731, 5190.480951904817, 5280.313559237313, 5288.894222115536, 5293.788248470057, 5299.894002119936, 3379.2142001610027, 3429.8971030869116, 3479.9826000869834, 3494.1614012637037, 3541.1678255609913, 1145.2555838704825, 1165.056304393444, 1165.3066425476827, 1165.4638866121595, 1208.5951206345885, 12522.499100035988, 12545.811812822723, 12559.748805023939, 12570.68573285666, 12571.685707857378, 4396.296592545177, 4470.396496472999, 4580.450345958507, 4616.584507394351, 4631.560001799824, 10625.203109766799, 10638.787224255471, 10651.520681569347, 10652.0, 10664.520096595672, 5311.893762124736, 5332.0, 5345.198220266913, 5357.598180136505, 5363.19552067193, 4355.346697995326, 4766.165920963817, 4906.607471402279, 4917.164082106051, 4929.186684197139, 3914.9804250978564, 3928.3910993796007, 3982.980085099556, 3993.600639935983, 4103.85636502721, 1224.0880543994604, 1227.1226073357593, 1233.808759642257, 1236.7031912341154, 1265.2155663488695, 939.0, 945.7304668169538, 999.5801763259449, 1013.1287093099928, 1016.974575635615, 6048.60684055535, 6366.904496432558, 6446.871062578816, 6484.902726459107, 6499.28507864144, 957.5020989085637, 1057.5082586597268, 1081.4808891732014, 1118.2228351295935, 1140.0252783869837, 4368.148211098805, 4386.780660966939, 4437.445319335083, 4474.843380481668, 4568.748718820497, 11131.833022504668, 11459.140564457699, 11504.137189710806, 11591.24656897299, 11612.88387116135, 11362.0, 11393.829092563617, 11429.085673146128, 11447.313161210353, 11457.942710286396, 7448.106227252656, 7679.500832445873, 7733.729319473904, 7825.0, 7849.882251766228, 6107.328193898757, 6183.165272688309, 6285.340039295808, 6407.871842563216, 6447.806565803034, 9958.850617240892, 10186.236032297458, 10211.489425528842, 10312.690619281433, 10424.0, 10330.328528645614, 10437.843432348673, 10451.84322235152, 10490.685279441628, 10571.682849514527, 8138.267555919995, 8195.34437245007, 8223.54770487629, 8272.669093236203, 8273.4622249556, 8806.471611703319, 8859.734207973772, 8877.556122193735, 8885.511296878734, 8942.955285223532, 7784.84430311402, 7970.4420690553425, 8032.036155661358, 8098.797530061795, 8136.06435259929, 7890.723824666109, 7924.445288829726, 7984.760457186294, 7987.600619968862, 7994.680212791423, 6971.128608923885, 7169.964150179216, 7232.312930271616, 7241.275872412716, 7252.456065795192, 5365.2220428036935, 5365.758540865749, 5368.114261146867, 5370.140777475585, 5379.1393377059485, 5463.890722185454, 5531.612787105025, 5537.667739935617, 5596.944030559643, 5635.126555383922], "value": 4763.16144757567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.8903439279056, 312.4750419295583, 321.6477956637482, 327.17551769540756, 327.8426355349431, 5144.0, 5640.3795582486, 5720.542356611471, 5761.337446193684, 5784.623999440033, 5468.070428027235, 5582.49757521823, 5599.300087489064, 5615.382307946133, 5629.943700563003, 4245.257080011002, 4254.808533615995, 4273.380359847836, 4274.781687219143, 4285.314349704048, 4268.231718290722, 4276.166147601219, 4307.504636966742, 4353.67347448941, 4358.97820510897, 4146.8133933972895, 4293.248681480744, 4299.978500107495, 4310.310350343945, 4349.325854492543, 4297.978510107429, 4299.763513006784, 4327.459067616533, 4327.785019052035, 4338.327559228324, 3788.3181027415053, 3794.7042039566218, 3794.753341032824, 3806.809659517013, 3809.257194847006, 5442.809501667422, 5465.398806131322, 5481.835544933659, 5594.706170470128, 5600.663960162363, 4856.615864478642, 4927.581155601778, 4931.186354251544, 4938.654294199408, 4944.653874228806, 5867.325257595346, 5908.291005079375, 5912.0, 5947.851303717398, 5952.821415357546, 3952.4268980997595, 4137.358709400048, 4167.333226683716, 4171.416001759756, 4191.371294305848, 6102.833494109616, 6128.40369722708, 6152.815415537541, 6153.784617538409, 6156.692165391757, 4254.787260636956, 4271.0, 4275.0, 4292.613664770186, 4304.526502084768, 4086.0193553546933, 4279.7218180818145, 4295.248331541968, 4338.479382474124, 4344.739315641072, 4913.778879950411, 4932.818332175727, 4937.1606826839525, 4944.579710724557, 4944.728039957837, 5933.762649494059, 5942.554308426886, 5951.761929522857, 5954.672493012839, 6005.789797357072, 1447.1461837515706, 1487.1820498725658, 1489.3744627256578, 1492.8059352284351, 1516.385863725193, 949.4872768704822, 968.162539403411, 988.2390559269322, 992.9751756206152, 993.7813680990171, 4986.276989836526, 5087.913955278318, 5096.847094587169, 5117.5394214520875, 5135.974320128375, 5279.52484276417, 5340.611441025284, 5378.489043540935, 5383.16560933056, 5403.567714582824, 4843.878903027453, 4945.9258111128365, 5004.774785134678, 5042.773075211624, 5059.595232381401, 2805.5651374037056, 2856.685764565896, 2861.585070164856, 2872.003957249691, 2885.1771402891254, 5409.513143817076, 5437.34751829783, 5482.342118945752, 5509.972450137724, 5531.419200983919, 5117.309163262912, 5394.514493695587, 5402.243685883979, 5437.302634208697, 5448.618596698272, 5419.376771671229, 5483.506484416422, 5509.741006187444, 5522.603598786717, 5526.397344770052, 5237.502437268454, 5253.212018197148, 5319.521243088141, 5395.784168633368, 5419.856483239632, 5582.441755824548, 6068.2692788244585, 6070.2412198475195, 6074.544409169242, 6089.5737298388685, 6245.6252624842655, 6261.154744109669, 6294.779682711083, 6297.1813664223355, 6300.936990630218, 4146.709730318848, 4154.169166166839, 4155.148194620036, 4244.681648876285, 4274.807633656431, 5884.676342801187, 6079.848003799763, 6101.328853826164, 6135.355787642412, 6145.0, 5871.7651293947765, 6003.3996600339615, 6003.459688628044, 6007.8197654070445, 6021.879562408815, 5903.203067585821, 5939.198208241832, 5961.850953726018, 5972.970135149297, 6013.458788709037, 5731.077150653114, 5918.496927761016, 5943.702814859326, 5972.492338151305, 5989.161517387656, 6001.939980600313, 6035.18524999137, 6036.336003039574, 6036.6679832609625, 6053.364396738279, 5600.963821693, 5894.410558944242, 5915.822525324247, 5940.524758019262, 5955.94519890637], "value": 4350.930662568127, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.4594373135744, 753.3257734327773, 770.6955752477768, 785.1520358013346, 870.4864130163203, 15388.15365154916, 15651.826312896623, 16053.357865685373, 16062.357505699758, 16118.113503757319, 14587.34356953937, 14784.6303842404, 14798.778018329735, 14807.925960370183, 14812.25938703066, 660.8546119853637, 789.1319548496665, 830.4726498673325, 834.6035633074272, 839.3578912132193, 835.6114406800837, 835.6197929941862, 836.6235194162621, 836.8451836410253, 837.3092198935872, 879.4020066354876, 881.0484676549312, 882.1839798186684, 882.8101958079012, 884.6328773558965, 873.1617647058799, 876.3427429427929, 877.8068824858489, 879.8768172455797, 880.520116536486, 634.7080343042206, 638.73811737188, 639.162696867101, 639.7185238495048, 641.3394203969918, 15392.30734616945, 15394.53816385499, 15400.152991585459, 15406.922965385213, 15417.691646167126, 13917.373718182705, 15350.232488375537, 15386.923065384713, 15530.0, 15551.766723499157, 13108.86891131086, 13436.462541498327, 13635.181889086687, 13790.379432925542, 13832.170069795844, 4027.3153563894207, 4040.9797951010055, 4621.930671039937, 4625.514320996281, 4676.018036212399, 80930.0, 81106.0, 83066.0, 83872.58063709704, 84278.57860710718, 11522.827157592643, 11539.538418463168, 11599.478023488964, 11842.052635789116, 11846.466908989116, 21320.36038918835, 21411.250606228707, 21426.464338391666, 21609.135634574755, 21717.67423488649, 8410.957945210235, 8493.830123397622, 8615.956920215358, 8667.0, 8842.0, 4439.467263928349, 4657.876336030339, 4698.083873644675, 4868.318435419044, 5015.799368025311, 3331.267121233325, 3423.8116903570044, 3441.6730410610953, 3496.30073985204, 3500.7024402925526, 637.1907677249867, 637.4135795068548, 646.2600322630561, 670.9228438729608, 671.378974448633, 567.821136342051, 664.2858926653867, 665.4144352969356, 678.9660516974131, 695.9930400696029, 9168.0, 9265.397749146285, 9985.950070249748, 10079.294449388472, 10094.444805535766, 569.7037540478927, 608.0, 627.9183706118175, 636.7962252079383, 637.8118455055769, 4531.637469002472, 4760.119377915097, 4793.904121917542, 4805.975970120127, 4823.855284341405, 69147.30852691409, 70377.64811175912, 70393.29606703867, 70419.64790176017, 72298.0, 107030.0, 107841.46079269554, 108865.0, 109604.0, 110397.44801276103, 93789.53105234567, 95105.0, 97200.51399742956, 99270.50364748275, 100395.0, 8744.562771861509, 8779.410074028305, 8834.204921557091, 8859.316729821314, 9114.0, 54828.72585637046, 56415.0, 57253.0, 57425.0, 57496.425035749104, 79625.0, 82079.0, 83021.16978830376, 85106.57446712727, 85242.0, 12196.329201893981, 12305.815412768994, 12324.876751232372, 12366.690832729253, 12657.620271391874, 13000.934995324962, 13001.0, 13041.087123901236, 13054.282014489294, 13265.734685306434, 12092.093093018235, 12377.566785162477, 12463.688407789878, 12564.492260928748, 12604.432800523815, 11681.357525336189, 11751.0, 11801.881981180079, 11814.468348924147, 11959.581414650445, 12362.814557781461, 12421.006319494238, 13775.38010789537, 14093.577192684235, 14584.48954286595, 11743.530258789895, 12061.75876482483, 12215.389230538616, 12315.753684926072, 12520.0, 11878.46546905374, 12266.632001039983, 12267.938660306641, 12362.134650574733, 12533.122681412213], "value": 7567.565261668211, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 107.0, 113.0, 113.0, 113.0, 115.0, 113.0, 113.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 146.0, 166.0, 120.0, 146.0, 147.0, 120.0, 182.0, 119.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 164.0, 166.0, 168.0, 161.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 147.0, 75.0, 84.0, 75.0, 76.0, 159.0, 78.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 149.0, 84.0, 85.0, 85.0, 149.0, 84.0, 83.0, 141.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 148.0, 148.0, 147.0, 149.0, 146.0, 147.0, 148.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 53.0, 55.0, 53.0, 51.0, 52.0, 51.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0, 61.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 76.0, 75.0, 76.0, 77.0, 79.0, 76.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 132.0, 121.0, 120.0, 121.0, 127.0, 120.0, 133.0, 166.0, 124.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 167.0, 163.0, 161.0, 161.0, 157.0, 158.0, 154.0, 157.0, 159.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 65.0, 62.0, 65.0, 63.0, 62.0, 63.0, 61.0], "value": 63.7, "unit": "score"}]}]} 23:45:02 INFO - Return code: 0 23:45:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:45:02 ERROR - # TBPL SUCCESS # 23:45:02 INFO - Running post-action listener: _resource_record_post_action 23:45:02 INFO - ##### 23:45:02 INFO - ##### Finished run-tests step (success) 23:45:02 INFO - ##### 23:45:02 INFO - Running post-run listener: _resource_record_post_run 23:45:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559157248; Read time: 12; Write time: 409128 23:45:02 INFO - TinderboxPrint: CPU usage
13.3% 23:45:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:45:02 INFO - TinderboxPrint: I/O write bytes / time
559,157,248 / 409,128 23:45:02 INFO - TinderboxPrint: CPU idle
8,216.6 (86.7%) 23:45:02 INFO - TinderboxPrint: CPU user
1,208.5 (12.7%) 23:45:02 INFO - TinderboxPrint: Swap in / out
0 / 0 23:45:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 243683328; Read time: 0; Write time: 223212 23:45:02 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 295260160; Read time: 0; Write time: 181452 23:45:02 INFO - Running post-run listener: _upload_blobber_files 23:45:02 INFO - Blob upload gear active. 23:45:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:45:02 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 23:45:02 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:45:02 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:45:03 INFO - (blobuploader) - INFO - Open directory for files ... 23:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:04 INFO - (blobuploader) - INFO - Done attempting. 23:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:09 INFO - (blobuploader) - INFO - Done attempting. 23:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:10 INFO - (blobuploader) - INFO - Done attempting. 23:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 23:45:10 INFO - Return code: 0 23:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d88cf5cfe2b6f15cba4b797217dcb517411bc2d5eb669799364682ecb9ce2bf5c837d8614ebd708c89e6d44ac90ca6a7dc8298c1db3798349ee92f4fa4562f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea3ab55f43de739bc9a9a531f302e4f423e69f47e61f26ca50b307ce5fe9de75214e375afd870dde82f22ebbe35773e176fd499aaf1d585fbce97e4f21ad722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/199eb1ece42c9ee12d87c05ed8ee55e3e9314ada136148ade1815f0655c944c134d3ba19f3dd603407c370d8628f35c6ea6f36993a5607ce84d6c64b222eadd7"} 23:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:45:10 INFO - Contents: 23:45:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d88cf5cfe2b6f15cba4b797217dcb517411bc2d5eb669799364682ecb9ce2bf5c837d8614ebd708c89e6d44ac90ca6a7dc8298c1db3798349ee92f4fa4562f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea3ab55f43de739bc9a9a531f302e4f423e69f47e61f26ca50b307ce5fe9de75214e375afd870dde82f22ebbe35773e176fd499aaf1d585fbce97e4f21ad722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/199eb1ece42c9ee12d87c05ed8ee55e3e9314ada136148ade1815f0655c944c134d3ba19f3dd603407c370d8628f35c6ea6f36993a5607ce84d6c64b222eadd7"} 23:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 23:45:10 INFO - Copying logs to upload dir... 23:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 23:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.594123 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-18 23:45:10.137594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:10.140771) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090 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/sha512/d88cf5cfe2b6f15cba4b797217dcb517411bc2d5eb669799364682ecb9ce2bf5c837d8614ebd708c89e6d44ac90ca6a7dc8298c1db3798349ee92f4fa4562f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea3ab55f43de739bc9a9a531f302e4f423e69f47e61f26ca50b307ce5fe9de75214e375afd870dde82f22ebbe35773e176fd499aaf1d585fbce97e4f21ad722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/199eb1ece42c9ee12d87c05ed8ee55e3e9314ada136148ade1815f0655c944c134d3ba19f3dd603407c370d8628f35c6ea6f36993a5607ce84d6c64b222eadd7"} build_url:https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/eJyD6SOyT56_W-pB0m0lLw/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/sha512/d88cf5cfe2b6f15cba4b797217dcb517411bc2d5eb669799364682ecb9ce2bf5c837d8614ebd708c89e6d44ac90ca6a7dc8298c1db3798349ee92f4fa4562f14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ea3ab55f43de739bc9a9a531f302e4f423e69f47e61f26ca50b307ce5fe9de75214e375afd870dde82f22ebbe35773e176fd499aaf1d585fbce97e4f21ad722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/199eb1ece42c9ee12d87c05ed8ee55e3e9314ada136148ade1815f0655c944c134d3ba19f3dd603407c370d8628f35c6ea6f36993a5607ce84d6c64b222eadd7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:10.167688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:10.168008) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468909475.731568-725681090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 23:45:10.251541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:45:10.251859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 23:45:10.252151) ========= ========= Total master_lag: 0.18 =========