builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1468065840.96 results: success (0) buildid: 20160709023047 builduid: 19433e5bb36e467c8c0e79b6b8308b5f revision: fe0ea08656ec28e9d33e381e0653ba65713a7db4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:00.962430) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:00.962883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:00.963209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:01.046519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:01.046775) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 05:04:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.8M=0s 2016-07-09 05:04:01 (36.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:01.148429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:01.148732) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020470 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:01.198231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 05:04:01.198539) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fe0ea08656ec28e9d33e381e0653ba65713a7db4 --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 fe0ea08656ec28e9d33e381e0653ba65713a7db4 --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=03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 05:04:01,556 truncating revision to first 12 chars 2016-07-09 05:04:01,556 Setting DEBUG logging. 2016-07-09 05:04:01,556 attempt 1/10 2016-07-09 05:04:01,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fe0ea08656ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 05:04:02,279 unpacking tar archive at: fx-team-fe0ea08656ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.040207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-09 05:04:02.251617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:02.251891) ========= script_repo_revision: fe0ea08656ec28e9d33e381e0653ba65713a7db4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:02.252295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:02.252612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 05:04:02.260296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-09 05:04:02.260605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:04:02 INFO - MultiFileLogger online at 20160709 05:04:02 in /builds/slave/test 05:04:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:04:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:02 INFO - {'append_to_log': False, 05:04:02 INFO - 'base_work_dir': '/builds/slave/test', 05:04:02 INFO - 'blob_upload_branch': 'Fx-Team', 05:04:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:02 INFO - 'branch': 'Fx-Team', 05:04:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:02 INFO - 'config_files': ('talos/linux_config.py',), 05:04:02 INFO - 'default_actions': ('clobber', 05:04:02 INFO - 'read-buildbot-config', 05:04:02 INFO - 'download-and-extract', 05:04:02 INFO - 'populate-webroot', 05:04:02 INFO - 'create-virtualenv', 05:04:02 INFO - 'install', 05:04:02 INFO - 'run-tests'), 05:04:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:02 INFO - 'download_minidump_stackwalk': True, 05:04:02 INFO - 'download_symbols': 'ondemand', 05:04:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:02 INFO - 'installer_path': 'installer.exe', 05:04:02 INFO - 'log_level': 'info', 05:04:02 INFO - 'log_name': 'talos', 05:04:02 INFO - 'log_to_console': True, 05:04:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:04:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:04:02 INFO - 'opt_config_files': (), 05:04:02 INFO - 'pip_index': False, 05:04:02 INFO - 'sps_profile': False, 05:04:02 INFO - 'sps_profile_interval': 0, 05:04:02 INFO - 'suite': 'dromaeojs', 05:04:02 INFO - 'system_bits': '32', 05:04:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:02 INFO - 'title': 'talos-linux64-ix-047', 05:04:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:02 INFO - 'use_talos_json': True, 05:04:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:02 INFO - 'work_dir': 'build'} 05:04:02 INFO - ##### 05:04:02 INFO - ##### Running clobber step. 05:04:02 INFO - ##### 05:04:02 INFO - Running pre-action listener: _resource_record_pre_action 05:04:02 INFO - Running main action method: clobber 05:04:02 INFO - rmtree: /builds/slave/test/build 05:04:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:03 INFO - Running post-action listener: _resource_record_post_action 05:04:03 INFO - ##### 05:04:03 INFO - ##### Finished clobber step (success) 05:04:03 INFO - ##### 05:04:03 INFO - ##### 05:04:03 INFO - ##### Running read-buildbot-config step. 05:04:03 INFO - ##### 05:04:03 INFO - Running pre-action listener: _resource_record_pre_action 05:04:03 INFO - Running main action method: read_buildbot_config 05:04:03 INFO - Using buildbot properties: 05:04:03 INFO - { 05:04:03 INFO - "project": "", 05:04:03 INFO - "product": "firefox", 05:04:03 INFO - "script_repo_revision": "production", 05:04:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:04:03 INFO - "repository": "", 05:04:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:04:03 INFO - "buildid": "20160709023047", 05:04:03 INFO - "pgo_build": "True", 05:04:03 INFO - "basedir": "/builds/slave/test", 05:04:03 INFO - "buildnumber": 268, 05:04:03 INFO - "slavename": "talos-linux64-ix-047", 05:04:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:04:03 INFO - "platform": "ubuntu64_hw", 05:04:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:04:03 INFO - "branch": "fx-team", 05:04:03 INFO - "repo_path": "integration/fx-team", 05:04:03 INFO - "revision": "fe0ea08656ec28e9d33e381e0653ba65713a7db4", 05:04:03 INFO - "stage_platform": "linux64-pgo", 05:04:03 INFO - "builduid": "19433e5bb36e467c8c0e79b6b8308b5f", 05:04:03 INFO - "slavebuilddir": "test" 05:04:03 INFO - } 05:04:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:04:03 INFO - Running post-action listener: _resource_record_post_action 05:04:03 INFO - ##### 05:04:03 INFO - ##### Finished read-buildbot-config step (success) 05:04:03 INFO - ##### 05:04:03 INFO - ##### 05:04:03 INFO - ##### Running download-and-extract step. 05:04:03 INFO - ##### 05:04:03 INFO - Running pre-action listener: _resource_record_pre_action 05:04:03 INFO - Running main action method: download_and_extract 05:04:03 INFO - mkdir: /builds/slave/test/build/tests 05:04:03 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')]} 05:04:03 INFO - https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:04:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:04:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:04:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:13 INFO - Downloaded 1361 bytes. 05:04:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:04:13 INFO - Using the following test package requirements: 05:04:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:04:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:04:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'jsshell-linux-x86_64.zip'], 05:04:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:04:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:04:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:04:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:04:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:04:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:04: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')]} 05:04:13 INFO - https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:04:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:04:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:04:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:18 INFO - Downloaded 24305234 bytes. 05:04:18 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'] 05:04:18 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 05:04:20 INFO - Return code: 0 05:04:20 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 05:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:20 INFO - https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:21 INFO - Downloaded 24305234 bytes. 05:04:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:04:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:04:23 INFO - Return code: 0 05:04:23 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')]} 05:04:23 INFO - https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:24 INFO - Downloaded 14403333 bytes. 05:04:24 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'] 05:04:24 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 05:04:24 INFO - Return code: 0 05:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:24 INFO - https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YPyyWxNSSRaB5keJsPFeVg/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 05:04:26 INFO - Downloaded 60452683 bytes. 05:04:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:04:26 INFO - mkdir: /builds/slave/test/properties 05:04:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:04:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:04:26 INFO - Contents: 05:04:26 INFO - build_url:https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:04:27 INFO - Running post-action listener: _resource_record_post_action 05:04:27 INFO - Running post-action listener: set_extra_try_arguments 05:04:27 INFO - ##### 05:04:27 INFO - ##### Finished download-and-extract step (success) 05:04:27 INFO - ##### 05:04:27 INFO - ##### 05:04:27 INFO - ##### Running populate-webroot step. 05:04:27 INFO - ##### 05:04:27 INFO - Running pre-action listener: _resource_record_pre_action 05:04:27 INFO - Running main action method: populate_webroot 05:04:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:27 INFO - '--tppagecycles', 05:04:27 INFO - '7'], 05:04:27 INFO - 'tests': ['tsvgm']}}, 05:04:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:04:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:04:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:04:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['damp', 'tps']}, 05:04:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'tests': ['damp', 'tps']}, 05:04:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['dromaeo_dom']}, 05:04:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['basic_compositor_video']}, 05:04:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:04:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['a11yr', 05:04:27 INFO - 'ts_paint', 05:04:27 INFO - 'tpaint', 05:04:27 INFO - 'sessionrestore', 05:04:27 INFO - 'sessionrestore_no_auto_restore', 05:04:27 INFO - 'tabpaint']}, 05:04:27 INFO - 'other-e10s': {'tests': ['a11yr', 05:04:27 INFO - 'ts_paint', 05:04:27 INFO - 'tpaint', 05:04:27 INFO - 'sessionrestore', 05:04:27 INFO - 'sessionrestore_no_auto_restore', 05:04:27 INFO - 'tabpaint']}, 05:04:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:04:27 INFO - 'ts_paint', 05:04:27 INFO - 'tpaint', 05:04:27 INFO - 'sessionrestore', 05:04:27 INFO - 'sessionrestore_no_auto_restore', 05:04:27 INFO - 'tabpaint']}, 05:04:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:04:27 INFO - 'ts_paint', 05:04:27 INFO - 'tpaint', 05:04:27 INFO - 'sessionrestore', 05:04:27 INFO - 'sessionrestore_no_auto_restore', 05:04:27 INFO - 'tabpaint']}, 05:04:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['a11yr', 05:04:27 INFO - 'ts_paint', 05:04:27 INFO - 'tpaint', 05:04:27 INFO - 'sessionrestore', 05:04:27 INFO - 'sessionrestore_no_auto_restore', 05:04:27 INFO - 'tabpaint']}, 05:04:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['a11yr', 05:04:27 INFO - 'ts_paint', 05:04:27 INFO - 'tpaint', 05:04:27 INFO - 'sessionrestore', 05:04:27 INFO - 'sessionrestore_no_auto_restore', 05:04:27 INFO - 'tabpaint']}, 05:04:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['tsvgx', 05:04:27 INFO - 'tsvgr_opacity', 05:04:27 INFO - 'tart', 05:04:27 INFO - 'tscrollx', 05:04:27 INFO - 'cart']}, 05:04:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:04:27 INFO - 'tsvgr_opacity', 05:04:27 INFO - 'tart', 05:04:27 INFO - 'tscrollx', 05:04:27 INFO - 'cart']}, 05:04:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'talos_options': ['--disable-e10s'], 05:04:27 INFO - 'tests': ['tp5o']}, 05:04:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'tests': ['tp5o']}, 05:04:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'talos_options': ['--disable-e10s', 05:04:27 INFO - '--xperf_path', 05:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:27 INFO - 'tests': ['tp5n']}, 05:04:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:27 INFO - 'talos_options': ['--xperf_path', 05:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:27 INFO - 'tests': ['tp5n']}}, 05:04:27 INFO - 'talos.zip': {'path': '', 05:04:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:27 INFO - Running post-action listener: _resource_record_post_action 05:04:27 INFO - ##### 05:04:27 INFO - ##### Finished populate-webroot step (success) 05:04:27 INFO - ##### 05:04:27 INFO - ##### 05:04:27 INFO - ##### Running create-virtualenv step. 05:04:27 INFO - ##### 05:04:27 INFO - Running pre-action listener: _resource_record_pre_action 05:04:27 INFO - Running main action method: create_virtualenv 05:04:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:04:27 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 05:04:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:04:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:27 INFO - Using real prefix '/usr' 05:04:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:30 INFO - Installing pip.................done. 05:04:30 INFO - Return code: 0 05:04:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:30 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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:30 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 05:04:30 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 05:04:30 INFO - Using env: {'DISPLAY': ':0', 05:04:30 INFO - 'HOME': '/home/cltbld', 05:04:30 INFO - 'LANG': 'en_US.UTF-8', 05:04:30 INFO - 'LANGUAGE': 'en_US:en', 05:04:30 INFO - 'LOGNAME': 'cltbld', 05:04:30 INFO - 'MAIL': '/var/mail/cltbld', 05:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:30 INFO - 'MOZ_NO_REMOTE': '1', 05:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:30 INFO - 'NO_EM_RESTART': '1', 05:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:30 INFO - 'PWD': '/builds/slave/test', 05:04:30 INFO - 'SHELL': '/bin/bash', 05:04:30 INFO - 'SHLVL': '1', 05:04:30 INFO - 'TERM': 'linux', 05:04:30 INFO - 'TMOUT': '86400', 05:04:30 INFO - 'USER': 'cltbld', 05:04:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:30 INFO - '_': '/tools/buildbot/bin/python'} 05:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:30 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 05:04:30 INFO - Cleaning up... 05:04:30 INFO - Return code: 0 05:04:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:30 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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:30 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 05:04:30 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 05:04:30 INFO - Using env: {'DISPLAY': ':0', 05:04:30 INFO - 'HOME': '/home/cltbld', 05:04:30 INFO - 'LANG': 'en_US.UTF-8', 05:04:30 INFO - 'LANGUAGE': 'en_US:en', 05:04:30 INFO - 'LOGNAME': 'cltbld', 05:04:30 INFO - 'MAIL': '/var/mail/cltbld', 05:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:30 INFO - 'MOZ_NO_REMOTE': '1', 05:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:30 INFO - 'NO_EM_RESTART': '1', 05:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:30 INFO - 'PWD': '/builds/slave/test', 05:04:30 INFO - 'SHELL': '/bin/bash', 05:04:30 INFO - 'SHLVL': '1', 05:04:30 INFO - 'TERM': 'linux', 05:04:30 INFO - 'TMOUT': '86400', 05:04:30 INFO - 'USER': 'cltbld', 05:04:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:30 INFO - '_': '/tools/buildbot/bin/python'} 05:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:30 INFO - Downloading/unpacking psutil>=3.1.1 05:04:30 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 05:04:30 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 05:04:30 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 05:04:30 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 05:04:30 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 05:04:30 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 05:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:32 INFO - Installing collected packages: psutil 05:04:32 INFO - Running setup.py install for psutil 05:04:32 INFO - building 'psutil._psutil_linux' extension 05:04:32 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 05:04:32 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 05:04:32 INFO - building 'psutil._psutil_posix' extension 05:04:32 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 05:04:33 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 05:04:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:33 INFO - Successfully installed psutil 05:04:33 INFO - Cleaning up... 05:04:33 INFO - Return code: 0 05:04:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:04:33 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')]} 05:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:33 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')]} 05:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:33 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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:33 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 05:04:33 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 05:04:33 INFO - Using env: {'DISPLAY': ':0', 05:04:33 INFO - 'HOME': '/home/cltbld', 05:04:33 INFO - 'LANG': 'en_US.UTF-8', 05:04:33 INFO - 'LANGUAGE': 'en_US:en', 05:04:33 INFO - 'LOGNAME': 'cltbld', 05:04:33 INFO - 'MAIL': '/var/mail/cltbld', 05:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:33 INFO - 'MOZ_NO_REMOTE': '1', 05:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:33 INFO - 'NO_EM_RESTART': '1', 05:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:33 INFO - 'PWD': '/builds/slave/test', 05:04:33 INFO - 'SHELL': '/bin/bash', 05:04:33 INFO - 'SHLVL': '1', 05:04:33 INFO - 'TERM': 'linux', 05:04:33 INFO - 'TMOUT': '86400', 05:04:33 INFO - 'USER': 'cltbld', 05:04:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:33 INFO - '_': '/tools/buildbot/bin/python'} 05:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:04:33 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 05:04:33 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 05:04:33 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 05:04:33 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 05:04:33 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 05:04:33 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 05:04:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:04:35 INFO - Installing collected packages: mozsystemmonitor 05:04:35 INFO - Running setup.py install for mozsystemmonitor 05:04:35 INFO - Successfully installed mozsystemmonitor 05:04:35 INFO - Cleaning up... 05:04:35 INFO - Return code: 0 05:04:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:04:35 INFO - Using env: {'DISPLAY': ':0', 05:04:35 INFO - 'HOME': '/home/cltbld', 05:04:35 INFO - 'LANG': 'en_US.UTF-8', 05:04:35 INFO - 'LANGUAGE': 'en_US:en', 05:04:35 INFO - 'LOGNAME': 'cltbld', 05:04:35 INFO - 'MAIL': '/var/mail/cltbld', 05:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:35 INFO - 'MOZ_NO_REMOTE': '1', 05:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:35 INFO - 'NO_EM_RESTART': '1', 05:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:35 INFO - 'PWD': '/builds/slave/test', 05:04:35 INFO - 'SHELL': '/bin/bash', 05:04:35 INFO - 'SHLVL': '1', 05:04:35 INFO - 'TERM': 'linux', 05:04:35 INFO - 'TMOUT': '86400', 05:04:35 INFO - 'USER': 'cltbld', 05:04:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:35 INFO - '_': '/tools/buildbot/bin/python'} 05:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:35 INFO - Downloading/unpacking jsonschema==2.5.1 05:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:37 INFO - warning: no files found matching '*.txt' 05:04:37 INFO - no previously-included directories found matching 'build' 05:04:37 INFO - no previously-included directories found matching 'dist' 05:04:37 INFO - no previously-included directories found matching '.git*' 05:04:37 INFO - Installing collected packages: jsonschema, functools32 05:04:37 INFO - Running setup.py install for functools32 05:04:38 INFO - warning: no files found matching '*.txt' 05:04:38 INFO - no previously-included directories found matching 'build' 05:04:38 INFO - no previously-included directories found matching 'dist' 05:04:38 INFO - no previously-included directories found matching '.git*' 05:04:38 INFO - Successfully installed jsonschema functools32 05:04:38 INFO - Cleaning up... 05:04:38 INFO - Return code: 0 05:04:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:04:38 INFO - Using env: {'DISPLAY': ':0', 05:04:38 INFO - 'HOME': '/home/cltbld', 05:04:38 INFO - 'LANG': 'en_US.UTF-8', 05:04:38 INFO - 'LANGUAGE': 'en_US:en', 05:04:38 INFO - 'LOGNAME': 'cltbld', 05:04:38 INFO - 'MAIL': '/var/mail/cltbld', 05:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:38 INFO - 'MOZ_NO_REMOTE': '1', 05:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:38 INFO - 'NO_EM_RESTART': '1', 05:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:38 INFO - 'PWD': '/builds/slave/test', 05:04:38 INFO - 'SHELL': '/bin/bash', 05:04:38 INFO - 'SHLVL': '1', 05:04:38 INFO - 'TERM': 'linux', 05:04:38 INFO - 'TMOUT': '86400', 05:04:38 INFO - 'USER': 'cltbld', 05:04:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:38 INFO - '_': '/tools/buildbot/bin/python'} 05:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:04:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:41 INFO - Downloading docopt-0.6.1.tar.gz 05:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:41 INFO - Running setup.py install for blobuploader 05:04:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:04:41 INFO - Running setup.py install for requests 05:04:41 INFO - Running setup.py install for docopt 05:04:41 INFO - Successfully installed blobuploader requests docopt 05:04:41 INFO - Cleaning up... 05:04:41 INFO - Return code: 0 05:04:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:41 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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:41 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 05:04:41 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 05:04:41 INFO - Using env: {'DISPLAY': ':0', 05:04:41 INFO - 'HOME': '/home/cltbld', 05:04:41 INFO - 'LANG': 'en_US.UTF-8', 05:04:41 INFO - 'LANGUAGE': 'en_US:en', 05:04:41 INFO - 'LOGNAME': 'cltbld', 05:04:41 INFO - 'MAIL': '/var/mail/cltbld', 05:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:41 INFO - 'MOZ_NO_REMOTE': '1', 05:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:41 INFO - 'NO_EM_RESTART': '1', 05:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:41 INFO - 'PWD': '/builds/slave/test', 05:04:41 INFO - 'SHELL': '/bin/bash', 05:04:41 INFO - 'SHLVL': '1', 05:04:41 INFO - 'TERM': 'linux', 05:04:41 INFO - 'TMOUT': '86400', 05:04:41 INFO - 'USER': 'cltbld', 05:04:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:41 INFO - '_': '/tools/buildbot/bin/python'} 05:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:41 INFO - Running setup.py (path:/tmp/pip-b6IacC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:41 INFO - Running setup.py (path:/tmp/pip-w1CHnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:42 INFO - Running setup.py (path:/tmp/pip-9TGowq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:42 INFO - Running setup.py (path:/tmp/pip-LJjYMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:42 INFO - Running setup.py (path:/tmp/pip-yTdkve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:42 INFO - Running setup.py (path:/tmp/pip-JmGiM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:42 INFO - Running setup.py (path:/tmp/pip-rI1Tup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:42 INFO - Running setup.py (path:/tmp/pip-d_CvNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:42 INFO - Running setup.py (path:/tmp/pip-Nx_bOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:42 INFO - Running setup.py (path:/tmp/pip-6yo0o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:42 INFO - Running setup.py (path:/tmp/pip-ovytVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:42 INFO - Running setup.py (path:/tmp/pip-bhxYeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:42 INFO - Running setup.py (path:/tmp/pip-KZq811-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:42 INFO - Running setup.py (path:/tmp/pip-4SoUrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:42 INFO - Running setup.py (path:/tmp/pip-U5zXXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:43 INFO - Running setup.py (path:/tmp/pip-Lxv3nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:43 INFO - Running setup.py (path:/tmp/pip-3HrymI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:43 INFO - Running setup.py install for manifestparser 05:04:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Running setup.py install for mozcrash 05:04:43 INFO - Running setup.py install for mozdebug 05:04:43 INFO - Running setup.py install for mozdevice 05:04:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Running setup.py install for mozfile 05:04:43 INFO - Running setup.py install for mozhttpd 05:04:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Running setup.py install for mozinfo 05:04:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Running setup.py install for mozInstall 05:04:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:04:43 INFO - Running setup.py install for mozleak 05:04:44 INFO - Running setup.py install for mozlog 05:04:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:04:44 INFO - Running setup.py install for moznetwork 05:04:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:04:44 INFO - Running setup.py install for mozprocess 05:04:44 INFO - Running setup.py install for mozprofile 05:04:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:44 INFO - Running setup.py install for mozrunner 05:04:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:44 INFO - Running setup.py install for mozscreenshot 05:04:44 INFO - Running setup.py install for moztest 05:04:44 INFO - Running setup.py install for mozversion 05:04:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:44 INFO - Cleaning up... 05:04:44 INFO - Return code: 0 05:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:44 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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:44 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 05:04:44 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 05:04:44 INFO - Using env: {'DISPLAY': ':0', 05:04:44 INFO - 'HOME': '/home/cltbld', 05:04:44 INFO - 'LANG': 'en_US.UTF-8', 05:04:44 INFO - 'LANGUAGE': 'en_US:en', 05:04:44 INFO - 'LOGNAME': 'cltbld', 05:04:44 INFO - 'MAIL': '/var/mail/cltbld', 05:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:44 INFO - 'MOZ_NO_REMOTE': '1', 05:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:44 INFO - 'NO_EM_RESTART': '1', 05:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:44 INFO - 'PWD': '/builds/slave/test', 05:04:44 INFO - 'SHELL': '/bin/bash', 05:04:44 INFO - 'SHLVL': '1', 05:04:44 INFO - 'TERM': 'linux', 05:04:44 INFO - 'TMOUT': '86400', 05:04:44 INFO - 'USER': 'cltbld', 05:04:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:44 INFO - '_': '/tools/buildbot/bin/python'} 05:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:45 INFO - Running setup.py (path:/tmp/pip-Q700lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:45 INFO - Running setup.py (path:/tmp/pip-8cxhFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:45 INFO - Running setup.py (path:/tmp/pip-IhCFZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:45 INFO - Running setup.py (path:/tmp/pip-HF4s4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:45 INFO - Running setup.py (path:/tmp/pip-P4aIRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:45 INFO - Running setup.py (path:/tmp/pip-izlxJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:45 INFO - Running setup.py (path:/tmp/pip-0OdR47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:45 INFO - Running setup.py (path:/tmp/pip-yoHZqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:45 INFO - Running setup.py (path:/tmp/pip-Dwg9p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:45 INFO - Running setup.py (path:/tmp/pip-WYUK46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:45 INFO - Running setup.py (path:/tmp/pip-UwQusa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:45 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)) 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:45 INFO - Running setup.py (path:/tmp/pip-2asiiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:46 INFO - Running setup.py (path:/tmp/pip-XxMThy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:46 INFO - Running setup.py (path:/tmp/pip-1rBQpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:46 INFO - Running setup.py (path:/tmp/pip-yWeb2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:46 INFO - Running setup.py (path:/tmp/pip-Iqk4fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:46 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)) 05:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:46 INFO - Running setup.py (path:/tmp/pip-3rkH7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:46 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)) 05:04:46 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)) 05:04:46 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)) 05:04:46 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)) 05:04:46 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)) 05:04:46 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)) 05:04:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:46 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 05:04:48 INFO - Downloading blessings-1.6.tar.gz 05:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:48 INFO - Installing collected packages: blessings 05:04:48 INFO - Running setup.py install for blessings 05:04:48 INFO - Successfully installed blessings 05:04:48 INFO - Cleaning up... 05:04:48 INFO - Return code: 0 05:04:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:04:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:48 INFO - Reading from file tmpfile_stdout 05:04:48 INFO - Current package versions: 05:04:48 INFO - argparse == 1.2.1 05:04:48 INFO - blessings == 1.6 05:04:48 INFO - blobuploader == 1.2.4 05:04:48 INFO - docopt == 0.6.1 05:04:48 INFO - functools32 == 3.2.3-2 05:04:48 INFO - jsonschema == 2.5.1 05:04:48 INFO - manifestparser == 1.1 05:04:48 INFO - mozInstall == 1.12 05:04:48 INFO - mozcrash == 0.17 05:04:48 INFO - mozdebug == 0.1 05:04:48 INFO - mozdevice == 0.48 05:04:48 INFO - mozfile == 1.2 05:04:48 INFO - mozhttpd == 0.7 05:04:48 INFO - mozinfo == 0.9 05:04:48 INFO - mozleak == 0.1 05:04:48 INFO - mozlog == 3.2 05:04:48 INFO - moznetwork == 0.27 05:04:48 INFO - mozprocess == 0.23 05:04:48 INFO - mozprofile == 0.28 05:04:48 INFO - mozrunner == 6.12 05:04:48 INFO - mozscreenshot == 0.1 05:04:48 INFO - mozsystemmonitor == 0.3 05:04:48 INFO - moztest == 0.7 05:04:48 INFO - mozversion == 1.4 05:04:48 INFO - psutil == 3.1.1 05:04:48 INFO - requests == 1.2.3 05:04:48 INFO - wsgiref == 0.1.2 05:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:48 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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:48 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 05:04:48 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 05:04:48 INFO - Using env: {'DISPLAY': ':0', 05:04:48 INFO - 'HOME': '/home/cltbld', 05:04:48 INFO - 'LANG': 'en_US.UTF-8', 05:04:48 INFO - 'LANGUAGE': 'en_US:en', 05:04:48 INFO - 'LOGNAME': 'cltbld', 05:04:48 INFO - 'MAIL': '/var/mail/cltbld', 05:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:48 INFO - 'MOZ_NO_REMOTE': '1', 05:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:48 INFO - 'NO_EM_RESTART': '1', 05:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:48 INFO - 'PWD': '/builds/slave/test', 05:04:48 INFO - 'SHELL': '/bin/bash', 05:04:48 INFO - 'SHLVL': '1', 05:04:48 INFO - 'TERM': 'linux', 05:04:48 INFO - 'TMOUT': '86400', 05:04:48 INFO - 'USER': 'cltbld', 05:04:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:48 INFO - '_': '/tools/buildbot/bin/python'} 05:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 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)) 05:04:49 INFO - Cleaning up... 05:04:49 INFO - Return code: 0 05:04:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:49 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 0x1476030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1737180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', '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 05:04:49 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 05:04:49 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 05:04:49 INFO - Using env: {'DISPLAY': ':0', 05:04:49 INFO - 'HOME': '/home/cltbld', 05:04:49 INFO - 'LANG': 'en_US.UTF-8', 05:04:49 INFO - 'LANGUAGE': 'en_US:en', 05:04:49 INFO - 'LOGNAME': 'cltbld', 05:04:49 INFO - 'MAIL': '/var/mail/cltbld', 05:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:49 INFO - 'MOZ_NO_REMOTE': '1', 05:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:49 INFO - 'NO_EM_RESTART': '1', 05:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:49 INFO - 'PWD': '/builds/slave/test', 05:04:49 INFO - 'SHELL': '/bin/bash', 05:04:49 INFO - 'SHLVL': '1', 05:04:49 INFO - 'TERM': 'linux', 05:04:49 INFO - 'TMOUT': '86400', 05:04:49 INFO - 'USER': 'cltbld', 05:04:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:49 INFO - '_': '/tools/buildbot/bin/python'} 05:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:04:49 INFO - Cleaning up... 05:04:49 INFO - Return code: 0 05:04:49 INFO - Running post-action listener: _resource_record_post_action 05:04:49 INFO - Running post-action listener: _start_resource_monitoring 05:04:49 INFO - Starting resource monitoring. 05:04:49 INFO - ##### 05:04:49 INFO - ##### Finished create-virtualenv step (success) 05:04:49 INFO - ##### 05:04:49 INFO - ##### 05:04:49 INFO - ##### Running install step. 05:04:49 INFO - ##### 05:04:49 INFO - Running pre-action listener: _resource_record_pre_action 05:04:49 INFO - Running main action method: install 05:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:49 INFO - Reading from file tmpfile_stdout 05:04:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:04:49 INFO - Reading from file tmpfile_stdout 05:04:49 INFO - Output received: 05:04:49 INFO - Usage: mozinstall [options] installer 05:04:49 INFO - Options: 05:04:49 INFO - -h, --help show this help message and exit 05:04:49 INFO - -d DEST, --destination=DEST 05:04:49 INFO - Directory to install application into. [default: 05:04:49 INFO - "/builds/slave/test"] 05:04:49 INFO - --app=APP Application being installed. [default: firefox] 05:04:49 INFO - mkdir: /builds/slave/test/build/application 05:04:49 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'] 05:04:49 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 05:05:06 INFO - Reading from file tmpfile_stdout 05:05:06 INFO - Output received: 05:05:06 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:06 INFO - Running post-action listener: _resource_record_post_action 05:05:06 INFO - ##### 05:05:06 INFO - ##### Finished install step (success) 05:05:06 INFO - ##### 05:05:06 INFO - ##### 05:05:06 INFO - ##### Running run-tests step. 05:05:06 INFO - ##### 05:05:06 INFO - Running pre-action listener: _resource_record_pre_action 05:05:06 INFO - Running main action method: run_tests 05:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:06 INFO - Python 2.7.3 05:05:06 INFO - Return code: 0 05:05:06 INFO - grabbing minidump binary from tooltool 05:05:06 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')]} 05:05:06 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 0x17353b0>, '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 0x17362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1736740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:06 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 05:05:06 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 05:05:06 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 05:05:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:06 INFO - Return code: 0 05:05:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:06 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:05:06 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:05:06 INFO - Using env: {'DISPLAY': ':0', 05:05:06 INFO - 'HOME': '/home/cltbld', 05:05:06 INFO - 'LANG': 'en_US.UTF-8', 05:05:06 INFO - 'LANGUAGE': 'en_US:en', 05:05:06 INFO - 'LOGNAME': 'cltbld', 05:05:06 INFO - 'MAIL': '/var/mail/cltbld', 05:05:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:06 INFO - 'MOZ_NO_REMOTE': '1', 05:05:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:06 INFO - 'NO_EM_RESTART': '1', 05:05:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:06 INFO - 'PWD': '/builds/slave/test', 05:05:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:06 INFO - 'SHELL': '/bin/bash', 05:05:06 INFO - 'SHLVL': '1', 05:05:06 INFO - 'TERM': 'linux', 05:05:06 INFO - 'TMOUT': '86400', 05:05:06 INFO - 'USER': 'cltbld', 05:05:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970', 05:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:06 INFO - '_': '/tools/buildbot/bin/python'} 05:05:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:05:06 INFO - mozversion application_buildid: 20160709023047 05:05:06 INFO - mozversion application_changeset: fe0ea08656ec28e9d33e381e0653ba65713a7db4 05:05:06 INFO - mozversion application_display_name: Nightly 05:05:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:06 INFO - mozversion application_name: Firefox 05:05:07 INFO - mozversion application_remotingname: firefox 05:05:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:05:07 INFO - mozversion application_vendor: Mozilla 05:05:07 INFO - mozversion application_version: 50.0a1 05:05:07 INFO - mozversion platform_buildid: 20160709023047 05:05:07 INFO - mozversion platform_changeset: fe0ea08656ec28e9d33e381e0653ba65713a7db4 05:05:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:05:07 INFO - mozversion platform_version: 50.0a1 05:05:07 INFO - using testdate: 1468065906 05:05:07 INFO - actual date: 1468065906 05:05:07 INFO - starting webserver on 'localhost:45946' 05:05:07 INFO - SUITE-START | Running 2 tests 05:05:07 INFO - TEST-START | dromaeo_css 05:05:07 INFO - operating with platform_type : linux_ 05:05:07 INFO - Initialising browser for dromaeo_css test... 05:05:07 INFO - TEST-INFO | started process 19120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyr4Tyo/profile http://localhost:45946/getInfo.html) 05:05:11 INFO - PROCESS | 19120 | __metrics Screen width/height:1600/1200 05:05:11 INFO - PROCESS | 19120 | colorDepth:24 05:05:11 INFO - PROCESS | 19120 | Browser inner width/height: 1024/697 05:05:11 INFO - PROCESS | 19120 | __metrics 05:05:11 INFO - PROCESS | 19120 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:12 INFO - TEST-INFO | 19120: exit 0 05:05:12 INFO - Browser initialized. 05:05:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:12 INFO - TEST-INFO | started process 19203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyr4Tyo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:24 INFO - PROCESS | 19203 | RSS: Main: 157880320 05:05:24 INFO - PROCESS | 19203 | 05:06:15 INFO - PROCESS | 19203 | 1468065975875 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] 05:08:23 INFO - PROCESS | 19203 | Cycle 1(1): loaded http://localhost:45946/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45946/tests/dromaeo/cssquery-ext.html) 05:08:25 INFO - PROCESS | 19203 | RSS: Main: 283807744 05:08:25 INFO - PROCESS | 19203 | 05:11:27 INFO - PROCESS | 19203 | Cycle 1(1): loaded http://localhost:45946/tests/dromaeo/cssquery-ext.html (next: http://localhost:45946/tests/dromaeo/cssquery-jquery.html) 05:11:28 INFO - PROCESS | 19203 | RSS: Main: 240140288 05:11:28 INFO - PROCESS | 19203 | 05:14:29 INFO - PROCESS | 19203 | Cycle 1(1): loaded http://localhost:45946/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45946/tests/dromaeo/cssquery-mootools.html) 05:14:30 INFO - PROCESS | 19203 | RSS: Main: 244428800 05:14:30 INFO - PROCESS | 19203 | 05:17:32 INFO - PROCESS | 19203 | Cycle 1(1): loaded http://localhost:45946/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45946/tests/dromaeo/cssquery-prototype.html) 05:17:33 INFO - PROCESS | 19203 | RSS: Main: 240734208 05:17:33 INFO - PROCESS | 19203 | 05:20:36 INFO - PROCESS | 19203 | Cycle 1(1): loaded http://localhost:45946/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45946/tests/dromaeo/cssquery-yui.html) 05:20:36 INFO - PROCESS | 19203 | RSS: Main: 220901376 05:20:36 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | Cycle 1(1): loaded http://localhost:45946/tests/dromaeo/cssquery-yui.html (next: http://localhost:45946/tests/dromaeo/cssquery-dojo.html) 05:23:39 INFO - PROCESS | 19203 | RSS: Main: 285450240 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | __start_tp_report 05:23:39 INFO - PROCESS | 19203 | _x_x_mozilla_page_load 05:23:39 INFO - PROCESS | 19203 | _x_x_mozilla_page_load_details 05:23:39 INFO - PROCESS | 19203 | |i|pagename|runs| 05:23:39 INFO - PROCESS | 19203 | |0;dojo.html;3007.7142671446213;3021.199382163726;3022.0631604202686;3054.8014379065344;3065.1264389648954;5154.355705536808;5201.661891977019;5288.841334759959;5335.066363386406;5341.145416733323;5260.736963151846;5266.499682530153;5293.444188360215;5321.175217841231;5348.705821179834;4777.641676874231;4781.163296423129;4828.855134345958;4846.248831431116;4881.658283920127;4930.531599498042;4936.58039066678;4941.160002799515;4958.776855041514;4987.127252730776;4700.905981880361;4745.620350371962;4746.762661866893;4863.489333619972;4864.318995340655;4780.4741478437345;4806.447258565275;4837.467878533358;4850.369451971256;4854.684445511066;4795.256735206014;4801.375821143264;4806.711597304138;4806.75966201692;4841.225403935354;5067.239914012891;5186.766595503212;5297.337832770903;5305.893882122375;5357.651752636066;5582.748776305036;5681.431856814327;5700.173474846124;5705.343885453143;5706.3152421709665;5722.942770572325;5725.656460612377;5730.19777231188;5737.3688894221605;5739.426057394269;5124.564412024983;5291.973540132313;5327.946720532784;5329.546988505943;5344.038073146871;5929.4070592941225;5936.881262374728;5938.851528711817;5940.970295148497;5946.078357854453;5695.886082278331;5696.23100881384;5705.828825135252;5706;5706.087026075808;5408.296921400193;5559.833205003856;5601.6358936668985;5604.159376093618;5764.5676574257095;5601.607887447921;5621.831345059655;5625.521830644359;5628.943710562924;5639.830805075854;5573.219749235111;5618.4662457066515;5622.044252477007;5624.072028115315;5632.464915832989;4177.624013838769;4272.700910936204;4326.65386769064;4335.566443355702;4353.281708518059;3861.092643228839;3862.9034274143373;3865.8646947356706;3902.31709450845;3905.4727611772046;5424.05079111154;5434.049041417736;5437.238786569884;5439.129739241703;5444.346678398539;5502.58730595207;5639.689817060019;5669.1496275558175;5699.601027928088;5732.71336433185;5422.539084177889;5433.2936718227165;5433.320834895638;5445.972770136124;5447.700376479253;4754.405699287589;4914.33656456381;4923.040007198633;4923.926141107886;4969.701817890866;5748.5688573357165;5802.071668533099;5807.709614519257;5826;5830.41695830422;5647.661140331593;5653.095504719226;5654.236678048575;5657.2928383952;5659.830205093689;5668.773249069991;5809.622374545641;5831.562632802472;5831.79588714393;5843.6201646894515;5592.468715472024;5643.633163844337;5697.7436015380235;5706.3152421708;5708.914366284592;5733.3406658234835;5734.827955161351;5734.856628584319;5739.770409183586;5742.684152371659;5348.973255133699;5562.054450743302;5595.860103497445;5616.157576363578;5616.915746263891;5399.163129714901;5489.890202196014;5495.340559132929;5517.172424136412;5530.640508366943;5449.6185267032515;5488.231647569263;5495.890082198253;5495.917561236504;5495.9832431000395;5354.839354819362;5513.2005859151;5576.247206627216;5585.078462053716;5624.409437009055;5460.481254280837;5498.037843377473;5503.229547863222;5523.364813046551;5550.916736248879 05:23:39 INFO - PROCESS | 19203 | |1;ext.html;586.4809643465535;606.557213234339;613.1660941120073;619.9504039676826;624.1698540940549;30501.84749076257;43700;44633.330500042444;44639.999999999956;44674.7766261169;45483.31775023369;45672.77163614186;45967.77016114915;46021.539784602144;46053.53946460535;8909.777255568597;9061.637534498612;9063.45619262843;9073.818523629523;9074.274058075338;8919.28645708345;8999.730008099768;9015.14356136166;9016.459012459274;9017.32370072244;9077.36458447909;9098.044705305914;9118.452892826419;9127.589258483351;9130.863037054416;9028.8645670315;9072.727818165466;9079.591418386122;9081.364304498687;9081.727548173565;8943.06097859722;8980.506072166028;8999.955000224956;9006.324525660602;9009.864852027225;43336.56663433388;43359.132817343474;43527.34708979368;43648.56351436509;43704.56295437068;3436.9656303436896;3650.5254316938895;3670.0457880950876;4065.5731148229306;4280.5505421930875;33471.6652833471;33799.155021124425;34018;34072.14819629504;34962.90222586653;4263.488381394252;4600.056988317387;4641.976790116061;4672.135654903854;4674.836380726692;347705;349012;349276;350690.2465487682;351119;57568.4243157563;57731;57966;58039;58040.70979645159;59652.70173649104;60015.399846001856;60258.698706506184;60285;60358.39641603616;17101.315947361967;17317.134143292784;17318.220680069426;17339.653206936044;17340.91329543344;13523.864761352457;13602.387892544859;13603.251821149734;13607;13611.931940340235;14440.205788681724;15974.121423321596;15988.600284992968;16029.679406411806;16140.919295403448;6597.50518711089;6724.428423583952;6749.5612785168805;6799.898001529981;6908.240093589701;809.9392545559107;882.6954700628273;1034.2398337222135;1038.4865498121087;1050.7425680708122;33060.33879322448;33495.995120146436;33526.49710254348;33766.38951071316;34222.48666270008;1122.6239209864623;1137.0732852725002;1138.6697857621364;1187.3588262338412;1198.484651599803;17294.82705172932;17389.47831565055;17488.475345739647;17564.736528952075;17633.55916102082;536688;536769;538132;541051;542735;57049.71475142598;57199.714001429726;57324;57372;57434;1252.6555197320627;1291.754566632337;1320.392619395089;1348.298884580013;1396.8184136062248;33013.339733205685;34274.31451371009;34432;34495;34625.26649538006;48889.51110488992;49049.26426103683;49265.75367123285;49322.75338623284;49493.752531237114;407680;410763;411806;412110;412922;27300.31749206286;28452.43095138127;28465.857670711513;29806.552901706058;40833.1833363337;49403.7529812363;49611.751941240065;49785;51126.48873511217;51227.2315915269;41188.49897758724;42574.787126065414;43061.56938430575;43131.78434107935;43463.34804977991;41780.791096044326;41789.37315940324;42184.789076054425;42324.36513452362;42952.35571466493;42238.366424504275;42302.153956921306;42819.357709633754;43113.56886431221;43168;35866.64133358633;37170.81414593018;37905.4314185293;37978;38159.23681526409;28259.576106358832;28357.858210708815;28720.42559148847;28891.42217155603;28912.42175156443 05:23:39 INFO - PROCESS | 19203 | |2;jquery.html;364.6171519904103;383.1379396358193;385.6201641383238;388.85223615026285;408.17955908623657;17817.821821781778;19902.900485497572;19989.400317990447;20870.478238044056;21032.789672103274;19921.701174482394;20105.899470502663;20371.28700495483;20533.691994620094;20567;5524.226608274845;5731.914021289674;5772.855678608047;5778.393268706767;5942.673152976585;5722.284714410699;5790.739416726257;5797.3043234811885;5799.246098007253;5802.564807639423;5574.916376254359;5749.942500575004;5770.682612456313;5772.5670574706855;5804;5805.36141024487;5810.1865738796605;5810.273715785527;5812.505936995361;5826.038703613898;5027.4721154279005;5308.973455132699;5309.41596424393;5370.838874833761;5376;14213.715725685532;14341.139531628136;14390.064645798095;14527.128372297697;14586.854131458656;2284.1776960294283;2370.7036620422446;2882.0999865462204;2936.8237905725723;2966.243607879977;10162.59349626014;10542.209334299881;10711.571537138505;12210.450529726184;14549.927250363786;1882.218879165145;1928.1997970842224;1930.2279088364767;1937.6124775044907;1947.5228569000544;78839.06954546111;87188.56405717994;87593.56203218942;87714.5614271931;88176;10994.28537145083;11035.234362502122;11037.83443248352;11080.944595277133;11244.49399777012;15499.457518986781;15537.223138843012;15589.922050389676;15626.140562269184;15630.531084067496;8145.429819912668;8297.543635100128;8409.663613455516;8505.74482765518;8515;8109.7161599343735;8196.8360632787;8223.835523289501;8292.626831792584;8381.161883811692;4762.452317983407;4828;4842;4902.779374928065;4913.238448040559;1964.9410517684491;1972.8520360972698;1990.741203643517;2014.284928850237;2045.6011077839976;996.6113215845826;1003.94478303694;1009.7526106104051;1048.9632862849917;1104.7017305327518;18758.343457978906;19751.20995160206;20937.37187884366;21056.26303079385;21092.47268818292;961.33667769239;1016.3393794033938;1049.1501883474257;1060.390275591538;1066.664000839733;10788.78422431547;11141.2201145919;11244.493997769956;11290.266132701348;11318.377489238172;169424;169989;462406;468091;469490;97257;97619;97775.51112244536;97941.51029244809;98967.50516247372;1067.6209945469402;1076.042322333124;1076.8707755069286;1083.2038451738124;1087.516055355375;17360.479185624452;17454.563635909202;17686.734698979784;17763.822361776216;18139.81860181381;43613.78193109014;43908.560914391725;44214.778926105166;44849;44862.55137448584;62687.6865615669;63492.682536587025;64877;65616.67191664012;66049;8769.824603507766;9002.684906028258;9011.774705632411;9025.097490250922;9323.347365684336;13237.470501179845;13799.2410417428;13948.302584870919;14000.229987350793;14031.158130511794;12027.75944481123;12208.267503949792;12232.449539770909;12313.56902508408;12466.626001219978;11794.29234245948;11795.233309834834;12082.308476813078;12123.696907577381;12125.69685757863;12266.693332666755;12269.93865030669;12406.689832754253;12420.068494863102;12649.747005060031;8769.868451973352;8805.69180078694;8892.955535222542;9044.14080662336;9110.954445227731;9270;12294.877051229374;12433;12678;12702.110852240625 05:23:39 INFO - PROCESS | 19203 | |3;mootools.html;1316.433933408634;1467.8605532474419;1499.7900293958844;1625.5854757036955;1756.4291605228304;7725.652345644446;8069.8386032279395;8075.676972921076;8251.298639615625;8258.421910466255;7977.242161994615;8117.310028647572;8149.95925020374;8150.184981501847;8160.061592916816;1943.7278780970676;2184.5849288635186;2258.54829034193;2263.0495192019307;2283.817294616427;2211.0160978364634;2213.103693004336;2214.7785221477884;2218.179273668745;2218.9334319970426;2192.134107027723;2220.134147682405;2247.83141264405;2252.68462415262;2253.0874995626796;1893.3941138835578;2144.8069673729283;2167.8374121940838;2214.5238773663577;2220.85564438311;2189.3541405285478;2199.7910198531113;2219.145628932856;2219.422950033003;2221.7222847144108;8270.462419942685;8305.709300174465;8337.374696897758;8337.458065225801;8338;4644.396228490308;4772.856814295576;4783.354247176621;4786.473487916326;4793.976030119862;3008.8345141017235;3067.6932306769368;3141.371725654878;3152.1646763607664;3170.7621928355466;1070.990516648221;1084.6312253833735;1099.4777480696685;1107.4462768615692;1117.4803716271972;10830.40432776197;10851.294665846774;10855.728606784814;10886.510107045122;10901.509432075576;4011.438398624195;4088.2232375848494;4195.895102622459;4216.494020717533;4275.422817919541;9647.951760241154;9663;9664.03359664042;9669.806603867883;9672.854907176397;4829.106615276185;4840.201366774443;4841.975790121097;4843.07981483517;4844.079624871334;3919.529656441245;4364.75993820343;4509.481409637868;4518.6611004174165;4586.380838586815;3631.2555926035097;3695.501107350527;3800.809959502014;3813.4089216171537;3829.463875057494;1048.6906362623045;1109.877913429522;1149.5344385523877;1190.6249531397755;1207.3459360675931;859.9441036332619;918.6968300460832;1003.7039073473343;1009.8283291840405;1012.9290949633603;5800.854978625483;6043.637381757108;6055.212822333068;6173.487495563616;6352.777652782131;965.888922773876;967.4437198610827;982.3418309732353;1012.4178597306578;1032.746976990627;4066.1461093170765;4176.352665336878;4183.644390226804;4191.517975432804;4205.516365617932;9711.562979665932;9779.070988256104;9887.307888447884;9997;10094.848577271347;9890.456024918554;9939.353941993748;9943.15483183923;9948.900510994943;9949.701508954742;7219.0976127984;7513.47405681608;7514.624268786539;7641.2740789624895;7645.808854778564;5571.442855714558;5649.519790817826;5728.942710572841;5767.221425107725;5794.478496935296;8879.200871921557;9042.864357034518;9119.179273865384;9191.954040230024;9258.861117083114;9353.204977576983;9476.47879366614;9489.240860730986;9490.952545237229;9497.382670126419;6493.610383377012;6672.633005184762;6685.064091027163;7319.2314806944505;7460.738874139379;7157.7136914522835;7705.499142555716;7900.920990790019;7997;8107.554084525408;7168.964155179191;7317.2316906726155;7404.481686282124;7454.6645400956;7516.173220945582;7254.5647261164495;7271.563706177435;7289.817754556178;7337.926620733938;7358.374538164316;6777.152855893013;6812.557183783038;6842.144731908512;6858.108445902001;6859.759908403182;5026.296318515338;5139.100657384868;5206.323177986837;5231.607085860058;5329.014132385521;5218.582513398843;5228.869278268074;5233.293505376725;5285.550728188147;5485.067538518381 05:23:39 INFO - PROCESS | 19203 | |4;prototype.html;311.3352991363439;314.04999875376984;315.24027094701756;320.40724659380135;323.0743918673003;5314.76083576239;5320.521153096221;5337.1994200869885;5337.866553336168;5384.757685904134;5246.554042906348;5307.920381194285;5310.3893052299;5314.229436731672;5329.733513324338;3971;4053.4730485037053;4136.255474014676;4147.108371700084;4180.811863466151;4115.814788334517;4144.8134833932545;4144.834206631746;4151.730137541065;4177.060161463662;3944.3097457944887;4103.302438585448;4111.588841115894;4128.2156390285745;4138.937915931264;4017.879463616096;4043.2115737431213;4053.8986525336954;4111.321631930728;4116.217918595457;3601.171730501973;3601.6853848345168;3629.7277704172293;3631.455281707765;3639.981800091009;5071.39143302806;5119.769610367543;5124.564412024983;5205.505476979681;5207.375114986188;4461.464624245112;4670.579647831712;4692.648051396159;4698.154332220199;4712.717236965793;5487.106948102898;5487.204355368449;5544.334679838405;5549.1676248562635;5554.638948468337;3801.7148713846295;3902.2195560887935;3907.8241479133508;3972.2254160438724;3993.1813978134414;5631.226163758403;5702.315722113373;5708.003298268401;5714.942850571482;5716.657000579937;3925.7644541327613;3957.861474848424;3977.204559088136;3982.004498875281;3989.2221016901426;3889.397143442771;4005.719599627998;4035.9192816143513;4044;4052;4604.641630718946;4616.95383046172;4618.191816432178;4622.237330840441;4628.4445866496235;5521.3926468088475;5541.2796336476;5562.803997140553;5582.609217354746;5598.692071936001;1378.9310534473436;1407.6903081322093;1413.7455258053649;1424.7435461617008;1424.8575142485877;869.5826003518347;871.9869201961976;879.5865943006777;884.7434244069148;903.5662881816634;5255.448177941337;5414.29614150158;5419.756110975016;5425.864353391197;5428.5385742211565;5636.464535869086;5655.830325090254;5660.377358490563;5704.429557044263;5725.198472213893;5198.194279886624;5349.1976203569775;5373.247745315659;5383.327084114486;5402.837914862561;2981.7465515431;3001.5347621118763;3003.294225856922;3021.5769792229107;3027.5155975043886;5766.884662306814;5816.970915145482;5841.678707671119;5845.853853653693;5852.648841069549;5514.200440936042;5736.62711923732;5740.540756739534;5760.337561180518;5781.219535362757;5714.228579141846;5721.912836561123;5790.160426738099;5830.912536312044;5844.6785426801935;5368.892622147613;5569.526590239713;5666.575006874584;5677.763674705543;5681.545476361964;5656.377798442086;5670.5180059695385;5685.77256909719;5706.229658995982;5734.3692193857805;5959.612625179349;5966.254218222723;5967.283925928917;5998.850028749316;6021.307549631849;3989.9401508976807;4068.9796551017057;4078.7144899856726;4092.877213683594;4096.32410652239;5713.257276554022;5750.194972703741;5757.280339957505;5775.711214439178;5801.912971305349;5408.188771684278;5640.182173584725;5678.914816277842;5681.630694005042;5706.80026199081;5534.667919924817;5536.944630553804;5554.166874968787;5555.805546806004;5563.7774489019985;5323.387810401853;5516.117421212587;5517;5564.276644036249;5601.843290333332;5496.917546236889;5602.327720673382;5622.2128901954575;5634.549236061187;5664.688442135722;5488;5493.862653433696;5522.972385138049;5543.362513311021;5562.610617256753 05:23:39 INFO - PROCESS | 19203 | |5;yui.html;755.6938394523958;780.2899361580961;793.3296364571935;847.7795773098992;855.4909828651954;14668.706625867477;14718.926405367985;14732.484363047295;14858.108513489171;14990.100593964356;13710.24593647349;13771.58685239442;13824.377902994363;13837.446502139903;13857.23785191814;659.6141257364447;674.0495900779902;677.052127022168;683.8222062263823;796.9123396426388;797.8643630582786;800.3917023062456;801.4910531812312;801.6633014134078;802.0175285275549;841.5455653946862;847.8685803700437;848.4485084694936;848.8217474330398;848.8217474330398;843.1821133500495;848.8896443462372;849.8980122385323;850.3792231670853;851.6465666748292;509.9056674515227;611.4680228201494;634.8095571328583;635.0664523150961;635.3170341882495;14340.28298585077;14673.046251993694;14694.632634184123;14757.409703611842;14783.260836958108;13540.661483462894;13707.862921370759;14586.635334116625;14807.48173813922;14952;13221.933890330487;13232.206067635876;13268.800967985488;13368.264745438997;13546.661333466644;4403.735775853427;4431;4478.126765280772;4507.414036175276;4570.200076285561;83536.58231708863;84663;85179.14820851774;86858.13141868563;87208.56395717981;11608.941955290169;11659.708507287385;11836.70408239801;11844.348560829065;11946.761064778655;19660.803391965896;20463;22932.16542676582;22994.310170694906;23067.423314417272;8365.832683346422;8469.872951905603;8659.830922825464;8935.553222338856;9073.863892041625;4979.726115063634;5019.121653710586;5041.647084704109;5085.694858308513;5093.286939828427;3364.4280472319765;3488.3720930232803;3491.9301613967577;3494.8602055917477;3500.8599656013985;609.1015751766109;613.4448324266546;626.4455956478549;641.3618449642636;645.8514541655352;753.9246075392417;762.8145363533437;778.6568169906978;784.2588753627881;797.5254723439544;9987.088669435088;10375.792484150426;10389.688309350731;10516.894831051592;10789.46052697362;664.5348256220665;754.5774366354859;757.0914902117481;764.1670579068841;779.0767939991129;4723;4950.282209079735;5156.4070131935305;5202.401723801736;5207.661502002357;125299;129169.35415323051;130222;132381;133739;77842;103943;105492;106067.46966265119;106102.46948765361;97588.51205743926;99153.50423247837;99505;100530.49734751426;101644.99999999852;10753.784924301313;10757.846236698635;11028.28316159447;11043.779124417306;11096;50743.238851418;55564.72217638886;57311.71344143253;57823.42176578349;58942.70528647329;60501.0924836119;70996.29003709897;71820;72160;75380;14378.424863005363;14436.855631443552;14462;14675;14906.403743850558;15057.322420490886;15116.470923517623;15559.691518745698;15717.921410392875;15768.921155394608;14483.109523714558;14778.704425911637;15114.319855606744;15489.690206195588;15509.457168999032;10649.840252396376;13765.587032389045;14045.859541404863;14209.147451152963;14281.214533200773;13273.933630331787;13746.587602371945;13931.373088210852;14067.718645627236;14230.359633816295;11328;11595.884041159818;11916.761664766484;12121.27272363661;12196.085293603193;12171.695707607381;12172.39138043112;12196.756064878475;12300.446479908247;12681.619551413472 05:23:39 INFO - PROCESS | 19203 | __end_tp_report 05:23:39 INFO - PROCESS | 19203 | __start_cc_report 05:23:39 INFO - PROCESS | 19203 | _x_x_mozilla_cycle_collect,1054 05:23:39 INFO - PROCESS | 19203 | __end_cc_report 05:23:39 INFO - PROCESS | 19203 | __startTimestamp1468067019769__endTimestamp 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | ------- Summary: start ------- 05:23:39 INFO - PROCESS | 19203 | Number of tests: 6 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | [#0] dojo.html Cycles:165 Average:5272.70 Median:5489.89 stddev:604.93 (11.0%) stddev-sans-first:580.10 05:23:39 INFO - PROCESS | 19203 | Values: 3007.7 3021.2 3022.1 3054.8 3065.1 5154.4 5201.7 5288.8 5335.1 5341.1 5260.7 5266.5 5293.4 5321.2 5348.7 4777.6 4781.2 4828.9 4846.2 4881.7 4930.5 4936.6 4941.2 4958.8 4987.1 4700.9 4745.6 4746.8 4863.5 4864.3 4780.5 4806.4 4837.5 4850.4 4854.7 4795.3 4801.4 4806.7 4806.8 4841.2 5067.2 5186.8 5297.3 5305.9 5357.7 5582.7 5681.4 5700.2 5705.3 5706.3 5722.9 5725.7 5730.2 5737.4 5739.4 5124.6 5292.0 5327.9 5329.5 5344.0 5929.4 5936.9 5938.9 5941.0 5946.1 5695.9 5696.2 5705.8 5706.0 5706.1 5408.3 5559.8 5601.6 5604.2 5764.6 5601.6 5621.8 5625.5 5628.9 5639.8 5573.2 5618.5 5622.0 5624.1 5632.5 4177.6 4272.7 4326.7 4335.6 4353.3 3861.1 3862.9 3865.9 3902.3 3905.5 5424.1 5434.0 5437.2 5439.1 5444.3 5502.6 5639.7 5669.1 5699.6 5732.7 5422.5 5433.3 5433.3 5446.0 5447.7 4754.4 4914.3 4923.0 4923.9 4969.7 5748.6 5802.1 5807.7 5826.0 5830.4 5647.7 5653.1 5654.2 5657.3 5659.8 5668.8 5809.6 5831.6 5831.8 5843.6 5592.5 5643.6 5697.7 5706.3 5708.9 5733.3 5734.8 5734.9 5739.8 5742.7 5349.0 5562.1 5595.9 5616.2 5616.9 5399.2 5489.9 5495.3 5517.2 5530.6 5449.6 5488.2 5495.9 5495.9 5496.0 5354.8 5513.2 5576.2 5585.1 5624.4 5460.5 5498.0 5503.2 5523.4 5550.9 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | [#1] ext.html Cycles:180 Average:60008.64 Median:43087.57 stddev:116598.12 (270.6%) stddev-sans-first:116839.85 05:23:39 INFO - PROCESS | 19203 | Values: 586.5 606.6 613.2 620.0 624.2 30501.8 43700.0 44633.3 44640.0 44674.8 45483.3 45672.8 45967.8 46021.5 46053.5 8909.8 9061.6 9063.5 9073.8 9074.3 8919.3 8999.7 9015.1 9016.5 9017.3 9077.4 9098.0 9118.5 9127.6 9130.9 9028.9 9072.7 9079.6 9081.4 9081.7 8943.1 8980.5 9000.0 9006.3 9009.9 43336.6 43359.1 43527.3 43648.6 43704.6 3437.0 3650.5 3670.0 4065.6 4280.6 33471.7 33799.2 34018.0 34072.1 34962.9 4263.5 4600.1 4642.0 4672.1 4674.8 347705.0 349012.0 349276.0 350690.2 351119.0 57568.4 57731.0 57966.0 58039.0 58040.7 59652.7 60015.4 60258.7 60285.0 60358.4 17101.3 17317.1 17318.2 17339.7 17340.9 13523.9 13602.4 13603.3 13607.0 13611.9 14440.2 15974.1 15988.6 16029.7 16140.9 6597.5 6724.4 6749.6 6799.9 6908.2 809.9 882.7 1034.2 1038.5 1050.7 33060.3 33496.0 33526.5 33766.4 34222.5 1122.6 1137.1 1138.7 1187.4 1198.5 17294.8 17389.5 17488.5 17564.7 17633.6 536688.0 536769.0 538132.0 541051.0 542735.0 57049.7 57199.7 57324.0 57372.0 57434.0 1252.7 1291.8 1320.4 1348.3 1396.8 33013.3 34274.3 34432.0 34495.0 34625.3 48889.5 49049.3 49265.8 49322.8 49493.8 407680.0 410763.0 411806.0 412110.0 412922.0 27300.3 28452.4 28465.9 29806.6 40833.2 49403.8 49611.8 49785.0 51126.5 51227.2 41188.5 42574.8 43061.6 43131.8 43463.3 41780.8 41789.4 42184.8 42324.4 42952.4 42238.4 42302.2 42819.4 43113.6 43168.0 35866.6 37170.8 37905.4 37978.0 38159.2 28259.6 28357.9 28720.4 28891.4 28912.4 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | [#2] jquery.html Cycles:180 Average:25634.43 Median:20985.08 stddev:63707.07 (303.6%) stddev-sans-first:63857.53 05:23:39 INFO - PROCESS | 19203 | Values: 364.6 383.1 385.6 388.9 408.2 17817.8 19902.9 19989.4 20870.5 21032.8 19921.7 20105.9 20371.3 20533.7 20567.0 5524.2 5731.9 5772.9 5778.4 5942.7 5722.3 5790.7 5797.3 5799.2 5802.6 5574.9 5749.9 5770.7 5772.6 5804.0 5805.4 5810.2 5810.3 5812.5 5826.0 5027.5 5309.0 5309.4 5370.8 5376.0 14213.7 14341.1 14390.1 14527.1 14586.9 2284.2 2370.7 2882.1 2936.8 2966.2 10162.6 10542.2 10711.6 12210.5 14549.9 1882.2 1928.2 1930.2 1937.6 1947.5 78839.1 87188.6 87593.6 87714.6 88176.0 10994.3 11035.2 11037.8 11080.9 11244.5 15499.5 15537.2 15589.9 15626.1 15630.5 8145.4 8297.5 8409.7 8505.7 8515.0 8109.7 8196.8 8223.8 8292.6 8381.2 4762.5 4828.0 4842.0 4902.8 4913.2 1964.9 1972.9 1990.7 2014.3 2045.6 996.6 1003.9 1009.8 1049.0 1104.7 18758.3 19751.2 20937.4 21056.3 21092.5 961.3 1016.3 1049.2 1060.4 1066.7 10788.8 11141.2 11244.5 11290.3 11318.4 169424.0 169989.0 462406.0 468091.0 469490.0 97257.0 97619.0 97775.5 97941.5 98967.5 1067.6 1076.0 1076.9 1083.2 1087.5 17360.5 17454.6 17686.7 17763.8 18139.8 43613.8 43908.6 44214.8 44849.0 44862.6 62687.7 63492.7 64877.0 65616.7 66049.0 8769.8 9002.7 9011.8 9025.1 9323.3 13237.5 13799.2 13948.3 14000.2 14031.2 12027.8 12208.3 12232.4 12313.6 12466.6 11794.3 11795.2 12082.3 12123.7 12125.7 12266.7 12269.9 12406.7 12420.1 12649.7 8769.9 8805.7 8893.0 9044.1 9111.0 9270.0 12294.9 12433.0 12678.0 12702.1 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | [#3] mootools.html Cycles:180 Average:5423.73 Median:5230.24 stddev:2990.07 (57.2%) stddev-sans-first:2982.52 05:23:39 INFO - PROCESS | 19203 | Values: 1316.4 1467.9 1499.8 1625.6 1756.4 7725.7 8069.8 8075.7 8251.3 8258.4 7977.2 8117.3 8150.0 8150.2 8160.1 1943.7 2184.6 2258.5 2263.0 2283.8 2211.0 2213.1 2214.8 2218.2 2218.9 2192.1 2220.1 2247.8 2252.7 2253.1 1893.4 2144.8 2167.8 2214.5 2220.9 2189.4 2199.8 2219.1 2219.4 2221.7 8270.5 8305.7 8337.4 8337.5 8338.0 4644.4 4772.9 4783.4 4786.5 4794.0 3008.8 3067.7 3141.4 3152.2 3170.8 1071.0 1084.6 1099.5 1107.4 1117.5 10830.4 10851.3 10855.7 10886.5 10901.5 4011.4 4088.2 4195.9 4216.5 4275.4 9648.0 9663.0 9664.0 9669.8 9672.9 4829.1 4840.2 4842.0 4843.1 4844.1 3919.5 4364.8 4509.5 4518.7 4586.4 3631.3 3695.5 3800.8 3813.4 3829.5 1048.7 1109.9 1149.5 1190.6 1207.3 859.9 918.7 1003.7 1009.8 1012.9 5800.9 6043.6 6055.2 6173.5 6352.8 965.9 967.4 982.3 1012.4 1032.7 4066.1 4176.4 4183.6 4191.5 4205.5 9711.6 9779.1 9887.3 9997.0 10094.8 9890.5 9939.4 9943.2 9948.9 9949.7 7219.1 7513.5 7514.6 7641.3 7645.8 5571.4 5649.5 5728.9 5767.2 5794.5 8879.2 9042.9 9119.2 9192.0 9258.9 9353.2 9476.5 9489.2 9491.0 9497.4 6493.6 6672.6 6685.1 7319.2 7460.7 7157.7 7705.5 7900.9 7997.0 8107.6 7169.0 7317.2 7404.5 7454.7 7516.2 7254.6 7271.6 7289.8 7337.9 7358.4 6777.2 6812.6 6842.1 6858.1 6859.8 5026.3 5139.1 5206.3 5231.6 5329.0 5218.6 5228.9 5233.3 5285.6 5485.1 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | [#4] prototype.html Cycles:180 Average:4665.75 Median:5384.04 stddev:1389.58 (25.8%) stddev-sans-first:1354.50 05:23:39 INFO - PROCESS | 19203 | Values: 311.3 314.0 315.2 320.4 323.1 5314.8 5320.5 5337.2 5337.9 5384.8 5246.6 5307.9 5310.4 5314.2 5329.7 3971.0 4053.5 4136.3 4147.1 4180.8 4115.8 4144.8 4144.8 4151.7 4177.1 3944.3 4103.3 4111.6 4128.2 4138.9 4017.9 4043.2 4053.9 4111.3 4116.2 3601.2 3601.7 3629.7 3631.5 3640.0 5071.4 5119.8 5124.6 5205.5 5207.4 4461.5 4670.6 4692.6 4698.2 4712.7 5487.1 5487.2 5544.3 5549.2 5554.6 3801.7 3902.2 3907.8 3972.2 3993.2 5631.2 5702.3 5708.0 5714.9 5716.7 3925.8 3957.9 3977.2 3982.0 3989.2 3889.4 4005.7 4035.9 4044.0 4052.0 4604.6 4617.0 4618.2 4622.2 4628.4 5521.4 5541.3 5562.8 5582.6 5598.7 1378.9 1407.7 1413.7 1424.7 1424.9 869.6 872.0 879.6 884.7 903.6 5255.4 5414.3 5419.8 5425.9 5428.5 5636.5 5655.8 5660.4 5704.4 5725.2 5198.2 5349.2 5373.2 5383.3 5402.8 2981.7 3001.5 3003.3 3021.6 3027.5 5766.9 5817.0 5841.7 5845.9 5852.6 5514.2 5736.6 5740.5 5760.3 5781.2 5714.2 5721.9 5790.2 5830.9 5844.7 5368.9 5569.5 5666.6 5677.8 5681.5 5656.4 5670.5 5685.8 5706.2 5734.4 5959.6 5966.3 5967.3 5998.9 6021.3 3989.9 4069.0 4078.7 4092.9 4096.3 5713.3 5750.2 5757.3 5775.7 5801.9 5408.2 5640.2 5678.9 5681.6 5706.8 5534.7 5536.9 5554.2 5555.8 5563.8 5323.4 5516.1 5517.0 5564.3 5601.8 5496.9 5602.3 5622.2 5634.5 5664.7 5488.0 5493.9 5523.0 5543.4 5562.6 05:23:39 INFO - PROCESS | 19203 | 05:23:39 INFO - PROCESS | 19203 | [#5] yui.html Cycles:180 Average:22146.50 Median:3426.40 stddev:32624.84 (952.2%) stddev-sans-first:32676.82 05:23:39 INFO - PROCESS | 19203 | Values: 755.7 780.3 793.3 847.8 855.5 14668.7 14718.9 14732.5 14858.1 14990.1 13710.2 13771.6 13824.4 13837.4 13857.2 659.6 674.0 677.1 683.8 796.9 797.9 800.4 801.5 801.7 802.0 841.5 847.9 848.4 848.8 848.8 843.2 848.9 849.9 850.4 851.6 509.9 611.5 634.8 635.1 635.3 14340.3 14673.0 14694.6 14757.4 14783.3 13540.7 13707.9 14586.6 14807.5 14952.0 13221.9 13232.2 13268.8 13368.3 13546.7 4403.7 4431.0 4478.1 4507.4 4570.2 83536.6 84663.0 85179.1 86858.1 87208.6 11608.9 11659.7 11836.7 11844.3 11946.8 19660.8 20463.0 22932.2 22994.3 23067.4 8365.8 8469.9 8659.8 8935.6 9073.9 4979.7 5019.1 5041.6 5085.7 5093.3 3364.4 3488.4 3491.9 3494.9 3500.9 609.1 613.4 626.4 641.4 645.9 753.9 762.8 778.7 784.3 797.5 9987.1 10375.8 10389.7 10516.9 10789.5 664.5 754.6 757.1 764.2 779.1 4723.0 4950.3 5156.4 5202.4 5207.7 125299.0 129169.4 130222.0 132381.0 133739.0 77842.0 103943.0 105492.0 106067.5 106102.5 97588.5 99153.5 99505.0 100530.5 101645.0 10753.8 10757.8 11028.3 11043.8 11096.0 50743.2 55564.7 57311.7 57823.4 58942.7 60501.1 70996.3 71820.0 72160.0 75380.0 14378.4 14436.9 14462.0 14675.0 14906.4 15057.3 15116.5 15559.7 15717.9 15768.9 14483.1 14778.7 15114.3 15489.7 15509.5 10649.8 13765.6 14045.9 14209.1 14281.2 13273.9 13746.6 13931.4 14067.7 14230.4 11328.0 11595.9 11916.8 12121.3 12196.1 12171.7 12172.4 12196.8 12300.4 12681.6 05:23:39 INFO - PROCESS | 19203 | -------- Summary: end -------- 05:23:39 INFO - PROCESS | 19203 | 05:23:40 INFO - TEST-INFO | 19203: exit 0 05:23:40 INFO - TEST-OK | dromaeo_css | took 1113440ms 05:23:40 INFO - TEST-START | kraken 05:23:40 INFO - operating with platform_type : linux_ 05:23:40 INFO - Initialising browser for kraken test... 05:23:40 INFO - TEST-INFO | started process 19394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIDjVVK/profile http://localhost:45946/getInfo.html) 05:23:44 INFO - PROCESS | 19394 | __metrics Screen width/height:1600/1200 05:23:44 INFO - PROCESS | 19394 | colorDepth:24 05:23:44 INFO - PROCESS | 19394 | Browser inner width/height: 1024/697 05:23:44 INFO - PROCESS | 19394 | __metrics 05:23:45 INFO - PROCESS | 19394 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:46 INFO - TEST-INFO | 19394: exit 0 05:23:46 INFO - Browser initialized. 05:23:46 INFO - Running cycle 1/1 for kraken test... 05:23:46 INFO - TEST-INFO | started process 19476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIDjVVK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:58 INFO - PROCESS | 19476 | RSS: Main: 157138944 05:23:58 INFO - PROCESS | 19476 | 05:24:00 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45946/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:01 INFO - PROCESS | 19476 | RSS: Main: 215359488 05:24:01 INFO - PROCESS | 19476 | 05:24:04 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45946/tests/kraken/driver.html?testName=audio-dft) 05:24:04 INFO - PROCESS | 19476 | RSS: Main: 203264000 05:24:04 INFO - PROCESS | 19476 | 05:24:07 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45946/tests/kraken/driver.html?testName=audio-fft) 05:24:08 INFO - PROCESS | 19476 | RSS: Main: 269668352 05:24:08 INFO - PROCESS | 19476 | 05:24:10 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45946/tests/kraken/driver.html?testName=audio-oscillator) 05:24:11 INFO - PROCESS | 19476 | RSS: Main: 180396032 05:24:11 INFO - PROCESS | 19476 | 05:24:13 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45946/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:13 INFO - PROCESS | 19476 | RSS: Main: 184217600 05:24:13 INFO - PROCESS | 19476 | 05:24:16 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45946/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:17 INFO - PROCESS | 19476 | RSS: Main: 220553216 05:24:17 INFO - PROCESS | 19476 | 05:24:20 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45946/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:21 INFO - PROCESS | 19476 | RSS: Main: 220901376 05:24:21 INFO - PROCESS | 19476 | 05:24:24 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45946/tests/kraken/driver.html?testName=json-parse-financial) 05:24:24 INFO - PROCESS | 19476 | RSS: Main: 221265920 05:24:24 INFO - PROCESS | 19476 | 05:24:26 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45946/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:27 INFO - PROCESS | 19476 | RSS: Main: 211996672 05:24:27 INFO - PROCESS | 19476 | 05:24:28 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:29 INFO - PROCESS | 19476 | RSS: Main: 212881408 05:24:29 INFO - PROCESS | 19476 | 05:24:31 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:32 INFO - PROCESS | 19476 | RSS: Main: 211886080 05:24:32 INFO - PROCESS | 19476 | 05:24:34 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:35 INFO - PROCESS | 19476 | RSS: Main: 224899072 05:24:35 INFO - PROCESS | 19476 | 05:24:37 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:38 INFO - PROCESS | 19476 | RSS: Main: 225636352 05:24:38 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | Cycle 1(1): loaded http://localhost:45946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45946/tests/kraken/driver.html?testName=ai-astar) 05:24:40 INFO - PROCESS | 19476 | RSS: Main: 267186176 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | __start_tp_report 05:24:40 INFO - PROCESS | 19476 | _x_x_mozilla_page_load 05:24:40 INFO - PROCESS | 19476 | _x_x_mozilla_page_load_details 05:24:40 INFO - PROCESS | 19476 | |i|pagename|runs| 05:24:40 INFO - PROCESS | 19476 | |0;ai-astar;103;114;110;112;111;112;112;111;110;111 05:24:40 INFO - PROCESS | 19476 | |1;audio-beat-detection;147;116;126;166;121;118;153;121;156;118 05:24:40 INFO - PROCESS | 19476 | |2;audio-dft;160;161;161;161;171;160;160;162;161;163 05:24:40 INFO - PROCESS | 19476 | |3;audio-fft;75;76;76;121;75;76;74;75;99;85 05:24:40 INFO - PROCESS | 19476 | |4;audio-oscillator;84;84;114;84;85;83;119;83;84;127 05:24:40 INFO - PROCESS | 19476 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;117;117;117 05:24:40 INFO - PROCESS | 19476 | |6;imaging-darkroom;145;145;145;146;145;146;146;146;145;145 05:24:40 INFO - PROCESS | 19476 | |7;imaging-desaturate;95;94;95;95;95;94;95;94;95;94 05:24:40 INFO - PROCESS | 19476 | |8;json-parse-financial;52;54;53;52;52;54;53;55;52;53 05:24:40 INFO - PROCESS | 19476 | |9;json-stringify-tinderbox;62;62;61;61;62;61;61;62;62;65 05:24:40 INFO - PROCESS | 19476 | |10;stanford-crypto-aes;84;79;75;75;75;84;76;80;75;82 05:24:40 INFO - PROCESS | 19476 | |11;stanford-crypto-ccm;124;124;118;122;117;122;121;121;164;122 05:24:40 INFO - PROCESS | 19476 | |12;stanford-crypto-pbkdf2;163;158;159;157;161;160;161;164;165;160 05:24:40 INFO - PROCESS | 19476 | |13;stanford-crypto-sha256-iterative;65;64;64;63;64;65;64;64;64;62 05:24:40 INFO - PROCESS | 19476 | __end_tp_report 05:24:40 INFO - PROCESS | 19476 | __start_cc_report 05:24:40 INFO - PROCESS | 19476 | _x_x_mozilla_cycle_collect,1636 05:24:40 INFO - PROCESS | 19476 | __end_cc_report 05:24:40 INFO - PROCESS | 19476 | __startTimestamp1468067080418__endTimestamp 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | ------- Summary: start ------- 05:24:40 INFO - PROCESS | 19476 | Number of tests: 14 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.91 (2.6%) stddev-sans-first:1.24 05:24:40 INFO - PROCESS | 19476 | Values: 103.0 114.0 110.0 112.0 111.0 112.0 112.0 111.0 110.0 111.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:136.50 stddev:19.08 (14.0%) stddev-sans-first:19.66 05:24:40 INFO - PROCESS | 19476 | Values: 147.0 116.0 126.0 166.0 121.0 118.0 153.0 121.0 156.0 118.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.00 stddev:3.30 (2.0%) stddev-sans-first:3.42 05:24:40 INFO - PROCESS | 19476 | Values: 160.0 161.0 161.0 161.0 171.0 160.0 160.0 162.0 161.0 163.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:15.36 (20.2%) stddev-sans-first:16.00 05:24:40 INFO - PROCESS | 19476 | Values: 75.0 76.0 76.0 121.0 75.0 76.0 74.0 75.0 99.0 85.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:17.74 (21.1%) stddev-sans-first:18.39 05:24:40 INFO - PROCESS | 19476 | Values: 84.0 84.0 114.0 84.0 85.0 83.0 119.0 83.0 84.0 127.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:24:40 INFO - PROCESS | 19476 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:24:40 INFO - PROCESS | 19476 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:24:40 INFO - PROCESS | 19476 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.05 (2.0%) stddev-sans-first:1.05 05:24:40 INFO - PROCESS | 19476 | Values: 52.0 54.0 53.0 52.0 52.0 54.0 53.0 55.0 52.0 53.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 05:24:40 INFO - PROCESS | 19476 | Values: 62.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 62.0 65.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:79.50 stddev:3.81 (4.8%) stddev-sans-first:3.48 05:24:40 INFO - PROCESS | 19476 | Values: 84.0 79.0 75.0 75.0 75.0 84.0 76.0 80.0 75.0 82.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:122.00 stddev:13.71 (11.2%) stddev-sans-first:14.53 05:24:40 INFO - PROCESS | 19476 | Values: 124.0 124.0 118.0 122.0 117.0 122.0 121.0 121.0 164.0 122.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:2.57 (1.6%) stddev-sans-first:2.60 05:24:40 INFO - PROCESS | 19476 | Values: 163.0 158.0 159.0 157.0 161.0 160.0 161.0 164.0 165.0 160.0 05:24:40 INFO - PROCESS | 19476 | 05:24:40 INFO - PROCESS | 19476 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 05:24:40 INFO - PROCESS | 19476 | Values: 65.0 64.0 64.0 63.0 64.0 65.0 64.0 64.0 64.0 62.0 05:24:40 INFO - PROCESS | 19476 | -------- Summary: end -------- 05:24:40 INFO - PROCESS | 19476 | 05:24:41 INFO - TEST-INFO | 19476: exit 0 05:24:41 INFO - TEST-OK | kraken | took 60947ms 05:24:41 INFO - SUITE-END | took 1174s 05:24:41 INFO - Completed test suite (00:19:34) 05:24:41 INFO - javascript benchmark 05:24:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.7142671446213, 3021.199382163726, 3022.0631604202686, 3054.8014379065344, 3065.1264389648954, 5154.355705536808, 5201.661891977019, 5288.841334759959, 5335.066363386406, 5341.145416733323, 5260.736963151846, 5266.499682530153, 5293.444188360215, 5321.175217841231, 5348.705821179834, 4777.641676874231, 4781.163296423129, 4828.855134345958, 4846.248831431116, 4881.658283920127, 4930.531599498042, 4936.58039066678, 4941.160002799515, 4958.776855041514, 4987.127252730776, 4700.905981880361, 4745.620350371962, 4746.762661866893, 4863.489333619972, 4864.318995340655, 4780.4741478437345, 4806.447258565275, 4837.467878533358, 4850.369451971256, 4854.684445511066, 4795.256735206014, 4801.375821143264, 4806.711597304138, 4806.75966201692, 4841.225403935354, 5067.239914012891, 5186.766595503212, 5297.337832770903, 5305.893882122375, 5357.651752636066, 5582.748776305036, 5681.431856814327, 5700.173474846124, 5705.343885453143, 5706.3152421709665, 5722.942770572325, 5725.656460612377, 5730.19777231188, 5737.3688894221605, 5739.426057394269, 5124.564412024983, 5291.973540132313, 5327.946720532784, 5329.546988505943, 5344.038073146871, 5929.4070592941225, 5936.881262374728, 5938.851528711817, 5940.970295148497, 5946.078357854453, 5695.886082278331, 5696.23100881384, 5705.828825135252, 5706.0, 5706.087026075808, 5408.296921400193, 5559.833205003856, 5601.6358936668985, 5604.159376093618, 5764.5676574257095, 5601.607887447921, 5621.831345059655, 5625.521830644359, 5628.943710562924, 5639.830805075854, 5573.219749235111, 5618.4662457066515, 5622.044252477007, 5624.072028115315, 5632.464915832989, 4177.624013838769, 4272.700910936204, 4326.65386769064, 4335.566443355702, 4353.281708518059, 3861.092643228839, 3862.9034274143373, 3865.8646947356706, 3902.31709450845, 3905.4727611772046, 5424.05079111154, 5434.049041417736, 5437.238786569884, 5439.129739241703, 5444.346678398539, 5502.58730595207, 5639.689817060019, 5669.1496275558175, 5699.601027928088, 5732.71336433185, 5422.539084177889, 5433.2936718227165, 5433.320834895638, 5445.972770136124, 5447.700376479253, 4754.405699287589, 4914.33656456381, 4923.040007198633, 4923.926141107886, 4969.701817890866, 5748.5688573357165, 5802.071668533099, 5807.709614519257, 5826.0, 5830.41695830422, 5647.661140331593, 5653.095504719226, 5654.236678048575, 5657.2928383952, 5659.830205093689, 5668.773249069991, 5809.622374545641, 5831.562632802472, 5831.79588714393, 5843.6201646894515, 5592.468715472024, 5643.633163844337, 5697.7436015380235, 5706.3152421708, 5708.914366284592, 5733.3406658234835, 5734.827955161351, 5734.856628584319, 5739.770409183586, 5742.684152371659, 5348.973255133699, 5562.054450743302, 5595.860103497445, 5616.157576363578, 5616.915746263891, 5399.163129714901, 5489.890202196014, 5495.340559132929, 5517.172424136412, 5530.640508366943, 5449.6185267032515, 5488.231647569263, 5495.890082198253, 5495.917561236504, 5495.9832431000395, 5354.839354819362, 5513.2005859151, 5576.247206627216, 5585.078462053716, 5624.409437009055, 5460.481254280837, 5498.037843377473, 5503.229547863222, 5523.364813046551, 5550.916736248879], "value": 5231.222066688793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.4809643465535, 606.557213234339, 613.1660941120073, 619.9504039676826, 624.1698540940549, 30501.84749076257, 43700.0, 44633.330500042444, 44639.999999999956, 44674.7766261169, 45483.31775023369, 45672.77163614186, 45967.77016114915, 46021.539784602144, 46053.53946460535, 8909.777255568597, 9061.637534498612, 9063.45619262843, 9073.818523629523, 9074.274058075338, 8919.28645708345, 8999.730008099768, 9015.14356136166, 9016.459012459274, 9017.32370072244, 9077.36458447909, 9098.044705305914, 9118.452892826419, 9127.589258483351, 9130.863037054416, 9028.8645670315, 9072.727818165466, 9079.591418386122, 9081.364304498687, 9081.727548173565, 8943.06097859722, 8980.506072166028, 8999.955000224956, 9006.324525660602, 9009.864852027225, 43336.56663433388, 43359.132817343474, 43527.34708979368, 43648.56351436509, 43704.56295437068, 3436.9656303436896, 3650.5254316938895, 3670.0457880950876, 4065.5731148229306, 4280.5505421930875, 33471.6652833471, 33799.155021124425, 34018.0, 34072.14819629504, 34962.90222586653, 4263.488381394252, 4600.056988317387, 4641.976790116061, 4672.135654903854, 4674.836380726692, 347705.0, 349012.0, 349276.0, 350690.2465487682, 351119.0, 57568.4243157563, 57731.0, 57966.0, 58039.0, 58040.70979645159, 59652.70173649104, 60015.399846001856, 60258.698706506184, 60285.0, 60358.39641603616, 17101.315947361967, 17317.134143292784, 17318.220680069426, 17339.653206936044, 17340.91329543344, 13523.864761352457, 13602.387892544859, 13603.251821149734, 13607.0, 13611.931940340235, 14440.205788681724, 15974.121423321596, 15988.600284992968, 16029.679406411806, 16140.919295403448, 6597.50518711089, 6724.428423583952, 6749.5612785168805, 6799.898001529981, 6908.240093589701, 809.9392545559107, 882.6954700628273, 1034.2398337222135, 1038.4865498121087, 1050.7425680708122, 33060.33879322448, 33495.995120146436, 33526.49710254348, 33766.38951071316, 34222.48666270008, 1122.6239209864623, 1137.0732852725002, 1138.6697857621364, 1187.3588262338412, 1198.484651599803, 17294.82705172932, 17389.47831565055, 17488.475345739647, 17564.736528952075, 17633.55916102082, 536688.0, 536769.0, 538132.0, 541051.0, 542735.0, 57049.71475142598, 57199.714001429726, 57324.0, 57372.0, 57434.0, 1252.6555197320627, 1291.754566632337, 1320.392619395089, 1348.298884580013, 1396.8184136062248, 33013.339733205685, 34274.31451371009, 34432.0, 34495.0, 34625.26649538006, 48889.51110488992, 49049.26426103683, 49265.75367123285, 49322.75338623284, 49493.752531237114, 407680.0, 410763.0, 411806.0, 412110.0, 412922.0, 27300.31749206286, 28452.43095138127, 28465.857670711513, 29806.552901706058, 40833.1833363337, 49403.7529812363, 49611.751941240065, 49785.0, 51126.48873511217, 51227.2315915269, 41188.49897758724, 42574.787126065414, 43061.56938430575, 43131.78434107935, 43463.34804977991, 41780.791096044326, 41789.37315940324, 42184.789076054425, 42324.36513452362, 42952.35571466493, 42238.366424504275, 42302.153956921306, 42819.357709633754, 43113.56886431221, 43168.0, 35866.64133358633, 37170.81414593018, 37905.4314185293, 37978.0, 38159.23681526409, 28259.576106358832, 28357.858210708815, 28720.42559148847, 28891.42217155603, 28912.42175156443], "value": 20362.46250382115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6171519904103, 383.1379396358193, 385.6201641383238, 388.85223615026285, 408.17955908623657, 17817.821821781778, 19902.900485497572, 19989.400317990447, 20870.478238044056, 21032.789672103274, 19921.701174482394, 20105.899470502663, 20371.28700495483, 20533.691994620094, 20567.0, 5524.226608274845, 5731.914021289674, 5772.855678608047, 5778.393268706767, 5942.673152976585, 5722.284714410699, 5790.739416726257, 5797.3043234811885, 5799.246098007253, 5802.564807639423, 5574.916376254359, 5749.942500575004, 5770.682612456313, 5772.5670574706855, 5804.0, 5805.36141024487, 5810.1865738796605, 5810.273715785527, 5812.505936995361, 5826.038703613898, 5027.4721154279005, 5308.973455132699, 5309.41596424393, 5370.838874833761, 5376.0, 14213.715725685532, 14341.139531628136, 14390.064645798095, 14527.128372297697, 14586.854131458656, 2284.1776960294283, 2370.7036620422446, 2882.0999865462204, 2936.8237905725723, 2966.243607879977, 10162.59349626014, 10542.209334299881, 10711.571537138505, 12210.450529726184, 14549.927250363786, 1882.218879165145, 1928.1997970842224, 1930.2279088364767, 1937.6124775044907, 1947.5228569000544, 78839.06954546111, 87188.56405717994, 87593.56203218942, 87714.5614271931, 88176.0, 10994.28537145083, 11035.234362502122, 11037.83443248352, 11080.944595277133, 11244.49399777012, 15499.457518986781, 15537.223138843012, 15589.922050389676, 15626.140562269184, 15630.531084067496, 8145.429819912668, 8297.543635100128, 8409.663613455516, 8505.74482765518, 8515.0, 8109.7161599343735, 8196.8360632787, 8223.835523289501, 8292.626831792584, 8381.161883811692, 4762.452317983407, 4828.0, 4842.0, 4902.779374928065, 4913.238448040559, 1964.9410517684491, 1972.8520360972698, 1990.741203643517, 2014.284928850237, 2045.6011077839976, 996.6113215845826, 1003.94478303694, 1009.7526106104051, 1048.9632862849917, 1104.7017305327518, 18758.343457978906, 19751.20995160206, 20937.37187884366, 21056.26303079385, 21092.47268818292, 961.33667769239, 1016.3393794033938, 1049.1501883474257, 1060.390275591538, 1066.664000839733, 10788.78422431547, 11141.2201145919, 11244.493997769956, 11290.266132701348, 11318.377489238172, 169424.0, 169989.0, 462406.0, 468091.0, 469490.0, 97257.0, 97619.0, 97775.51112244536, 97941.51029244809, 98967.50516247372, 1067.6209945469402, 1076.042322333124, 1076.8707755069286, 1083.2038451738124, 1087.516055355375, 17360.479185624452, 17454.563635909202, 17686.734698979784, 17763.822361776216, 18139.81860181381, 43613.78193109014, 43908.560914391725, 44214.778926105166, 44849.0, 44862.55137448584, 62687.6865615669, 63492.682536587025, 64877.0, 65616.67191664012, 66049.0, 8769.824603507766, 9002.684906028258, 9011.774705632411, 9025.097490250922, 9323.347365684336, 13237.470501179845, 13799.2410417428, 13948.302584870919, 14000.229987350793, 14031.158130511794, 12027.75944481123, 12208.267503949792, 12232.449539770909, 12313.56902508408, 12466.626001219978, 11794.29234245948, 11795.233309834834, 12082.308476813078, 12123.696907577381, 12125.69685757863, 12266.693332666755, 12269.93865030669, 12406.689832754253, 12420.068494863102, 12649.747005060031, 8769.868451973352, 8805.69180078694, 8892.955535222542, 9044.14080662336, 9110.954445227731, 9270.0, 12294.877051229374, 12433.0, 12678.0, 12702.110852240625], "value": 9338.482279783657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.433933408634, 1467.8605532474419, 1499.7900293958844, 1625.5854757036955, 1756.4291605228304, 7725.652345644446, 8069.8386032279395, 8075.676972921076, 8251.298639615625, 8258.421910466255, 7977.242161994615, 8117.310028647572, 8149.95925020374, 8150.184981501847, 8160.061592916816, 1943.7278780970676, 2184.5849288635186, 2258.54829034193, 2263.0495192019307, 2283.817294616427, 2211.0160978364634, 2213.103693004336, 2214.7785221477884, 2218.179273668745, 2218.9334319970426, 2192.134107027723, 2220.134147682405, 2247.83141264405, 2252.68462415262, 2253.0874995626796, 1893.3941138835578, 2144.8069673729283, 2167.8374121940838, 2214.5238773663577, 2220.85564438311, 2189.3541405285478, 2199.7910198531113, 2219.145628932856, 2219.422950033003, 2221.7222847144108, 8270.462419942685, 8305.709300174465, 8337.374696897758, 8337.458065225801, 8338.0, 4644.396228490308, 4772.856814295576, 4783.354247176621, 4786.473487916326, 4793.976030119862, 3008.8345141017235, 3067.6932306769368, 3141.371725654878, 3152.1646763607664, 3170.7621928355466, 1070.990516648221, 1084.6312253833735, 1099.4777480696685, 1107.4462768615692, 1117.4803716271972, 10830.40432776197, 10851.294665846774, 10855.728606784814, 10886.510107045122, 10901.509432075576, 4011.438398624195, 4088.2232375848494, 4195.895102622459, 4216.494020717533, 4275.422817919541, 9647.951760241154, 9663.0, 9664.03359664042, 9669.806603867883, 9672.854907176397, 4829.106615276185, 4840.201366774443, 4841.975790121097, 4843.07981483517, 4844.079624871334, 3919.529656441245, 4364.75993820343, 4509.481409637868, 4518.6611004174165, 4586.380838586815, 3631.2555926035097, 3695.501107350527, 3800.809959502014, 3813.4089216171537, 3829.463875057494, 1048.6906362623045, 1109.877913429522, 1149.5344385523877, 1190.6249531397755, 1207.3459360675931, 859.9441036332619, 918.6968300460832, 1003.7039073473343, 1009.8283291840405, 1012.9290949633603, 5800.854978625483, 6043.637381757108, 6055.212822333068, 6173.487495563616, 6352.777652782131, 965.888922773876, 967.4437198610827, 982.3418309732353, 1012.4178597306578, 1032.746976990627, 4066.1461093170765, 4176.352665336878, 4183.644390226804, 4191.517975432804, 4205.516365617932, 9711.562979665932, 9779.070988256104, 9887.307888447884, 9997.0, 10094.848577271347, 9890.456024918554, 9939.353941993748, 9943.15483183923, 9948.900510994943, 9949.701508954742, 7219.0976127984, 7513.47405681608, 7514.624268786539, 7641.2740789624895, 7645.808854778564, 5571.442855714558, 5649.519790817826, 5728.942710572841, 5767.221425107725, 5794.478496935296, 8879.200871921557, 9042.864357034518, 9119.179273865384, 9191.954040230024, 9258.861117083114, 9353.204977576983, 9476.47879366614, 9489.240860730986, 9490.952545237229, 9497.382670126419, 6493.610383377012, 6672.633005184762, 6685.064091027163, 7319.2314806944505, 7460.738874139379, 7157.7136914522835, 7705.499142555716, 7900.920990790019, 7997.0, 8107.554084525408, 7168.964155179191, 7317.2316906726155, 7404.481686282124, 7454.6645400956, 7516.173220945582, 7254.5647261164495, 7271.563706177435, 7289.817754556178, 7337.926620733938, 7358.374538164316, 6777.152855893013, 6812.557183783038, 6842.144731908512, 6858.108445902001, 6859.759908403182, 5026.296318515338, 5139.100657384868, 5206.323177986837, 5231.607085860058, 5329.014132385521, 5218.582513398843, 5228.869278268074, 5233.293505376725, 5285.550728188147, 5485.067538518381], "value": 4385.990292458074, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.3352991363439, 314.04999875376984, 315.24027094701756, 320.40724659380135, 323.0743918673003, 5314.76083576239, 5320.521153096221, 5337.1994200869885, 5337.866553336168, 5384.757685904134, 5246.554042906348, 5307.920381194285, 5310.3893052299, 5314.229436731672, 5329.733513324338, 3971.0, 4053.4730485037053, 4136.255474014676, 4147.108371700084, 4180.811863466151, 4115.814788334517, 4144.8134833932545, 4144.834206631746, 4151.730137541065, 4177.060161463662, 3944.3097457944887, 4103.302438585448, 4111.588841115894, 4128.2156390285745, 4138.937915931264, 4017.879463616096, 4043.2115737431213, 4053.8986525336954, 4111.321631930728, 4116.217918595457, 3601.171730501973, 3601.6853848345168, 3629.7277704172293, 3631.455281707765, 3639.981800091009, 5071.39143302806, 5119.769610367543, 5124.564412024983, 5205.505476979681, 5207.375114986188, 4461.464624245112, 4670.579647831712, 4692.648051396159, 4698.154332220199, 4712.717236965793, 5487.106948102898, 5487.204355368449, 5544.334679838405, 5549.1676248562635, 5554.638948468337, 3801.7148713846295, 3902.2195560887935, 3907.8241479133508, 3972.2254160438724, 3993.1813978134414, 5631.226163758403, 5702.315722113373, 5708.003298268401, 5714.942850571482, 5716.657000579937, 3925.7644541327613, 3957.861474848424, 3977.204559088136, 3982.004498875281, 3989.2221016901426, 3889.397143442771, 4005.719599627998, 4035.9192816143513, 4044.0, 4052.0, 4604.641630718946, 4616.95383046172, 4618.191816432178, 4622.237330840441, 4628.4445866496235, 5521.3926468088475, 5541.2796336476, 5562.803997140553, 5582.609217354746, 5598.692071936001, 1378.9310534473436, 1407.6903081322093, 1413.7455258053649, 1424.7435461617008, 1424.8575142485877, 869.5826003518347, 871.9869201961976, 879.5865943006777, 884.7434244069148, 903.5662881816634, 5255.448177941337, 5414.29614150158, 5419.756110975016, 5425.864353391197, 5428.5385742211565, 5636.464535869086, 5655.830325090254, 5660.377358490563, 5704.429557044263, 5725.198472213893, 5198.194279886624, 5349.1976203569775, 5373.247745315659, 5383.327084114486, 5402.837914862561, 2981.7465515431, 3001.5347621118763, 3003.294225856922, 3021.5769792229107, 3027.5155975043886, 5766.884662306814, 5816.970915145482, 5841.678707671119, 5845.853853653693, 5852.648841069549, 5514.200440936042, 5736.62711923732, 5740.540756739534, 5760.337561180518, 5781.219535362757, 5714.228579141846, 5721.912836561123, 5790.160426738099, 5830.912536312044, 5844.6785426801935, 5368.892622147613, 5569.526590239713, 5666.575006874584, 5677.763674705543, 5681.545476361964, 5656.377798442086, 5670.5180059695385, 5685.77256909719, 5706.229658995982, 5734.3692193857805, 5959.612625179349, 5966.254218222723, 5967.283925928917, 5998.850028749316, 6021.307549631849, 3989.9401508976807, 4068.9796551017057, 4078.7144899856726, 4092.877213683594, 4096.32410652239, 5713.257276554022, 5750.194972703741, 5757.280339957505, 5775.711214439178, 5801.912971305349, 5408.188771684278, 5640.182173584725, 5678.914816277842, 5681.630694005042, 5706.80026199081, 5534.667919924817, 5536.944630553804, 5554.166874968787, 5555.805546806004, 5563.7774489019985, 5323.387810401853, 5516.117421212587, 5517.0, 5564.276644036249, 5601.843290333332, 5496.917546236889, 5602.327720673382, 5622.2128901954575, 5634.549236061187, 5664.688442135722, 5488.0, 5493.862653433696, 5522.972385138049, 5543.362513311021, 5562.610617256753], "value": 4213.73681162573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.6938394523958, 780.2899361580961, 793.3296364571935, 847.7795773098992, 855.4909828651954, 14668.706625867477, 14718.926405367985, 14732.484363047295, 14858.108513489171, 14990.100593964356, 13710.24593647349, 13771.58685239442, 13824.377902994363, 13837.446502139903, 13857.23785191814, 659.6141257364447, 674.0495900779902, 677.052127022168, 683.8222062263823, 796.9123396426388, 797.8643630582786, 800.3917023062456, 801.4910531812312, 801.6633014134078, 802.0175285275549, 841.5455653946862, 847.8685803700437, 848.4485084694936, 848.8217474330398, 848.8217474330398, 843.1821133500495, 848.8896443462372, 849.8980122385323, 850.3792231670853, 851.6465666748292, 509.9056674515227, 611.4680228201494, 634.8095571328583, 635.0664523150961, 635.3170341882495, 14340.28298585077, 14673.046251993694, 14694.632634184123, 14757.409703611842, 14783.260836958108, 13540.661483462894, 13707.862921370759, 14586.635334116625, 14807.48173813922, 14952.0, 13221.933890330487, 13232.206067635876, 13268.800967985488, 13368.264745438997, 13546.661333466644, 4403.735775853427, 4431.0, 4478.126765280772, 4507.414036175276, 4570.200076285561, 83536.58231708863, 84663.0, 85179.14820851774, 86858.13141868563, 87208.56395717981, 11608.941955290169, 11659.708507287385, 11836.70408239801, 11844.348560829065, 11946.761064778655, 19660.803391965896, 20463.0, 22932.16542676582, 22994.310170694906, 23067.423314417272, 8365.832683346422, 8469.872951905603, 8659.830922825464, 8935.553222338856, 9073.863892041625, 4979.726115063634, 5019.121653710586, 5041.647084704109, 5085.694858308513, 5093.286939828427, 3364.4280472319765, 3488.3720930232803, 3491.9301613967577, 3494.8602055917477, 3500.8599656013985, 609.1015751766109, 613.4448324266546, 626.4455956478549, 641.3618449642636, 645.8514541655352, 753.9246075392417, 762.8145363533437, 778.6568169906978, 784.2588753627881, 797.5254723439544, 9987.088669435088, 10375.792484150426, 10389.688309350731, 10516.894831051592, 10789.46052697362, 664.5348256220665, 754.5774366354859, 757.0914902117481, 764.1670579068841, 779.0767939991129, 4723.0, 4950.282209079735, 5156.4070131935305, 5202.401723801736, 5207.661502002357, 125299.0, 129169.35415323051, 130222.0, 132381.0, 133739.0, 77842.0, 103943.0, 105492.0, 106067.46966265119, 106102.46948765361, 97588.51205743926, 99153.50423247837, 99505.0, 100530.49734751426, 101644.99999999852, 10753.784924301313, 10757.846236698635, 11028.28316159447, 11043.779124417306, 11096.0, 50743.238851418, 55564.72217638886, 57311.71344143253, 57823.42176578349, 58942.70528647329, 60501.0924836119, 70996.29003709897, 71820.0, 72160.0, 75380.0, 14378.424863005363, 14436.855631443552, 14462.0, 14675.0, 14906.403743850558, 15057.322420490886, 15116.470923517623, 15559.691518745698, 15717.921410392875, 15768.921155394608, 14483.109523714558, 14778.704425911637, 15114.319855606744, 15489.690206195588, 15509.457168999032, 10649.840252396376, 13765.587032389045, 14045.859541404863, 14209.147451152963, 14281.214533200773, 13273.933630331787, 13746.587602371945, 13931.373088210852, 14067.718645627236, 14230.359633816295, 11328.0, 11595.884041159818, 11916.761664766484, 12121.27272363661, 12196.085293603193, 12171.695707607381, 12172.39138043112, 12196.756064878475, 12300.446479908247, 12681.619551413472], "value": 7850.587994776419, "unit": "score"}], "name": "dromaeo_css", "value": 7242.679146512359, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 110.0, 112.0, 111.0, 112.0, 112.0, 111.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 126.0, 166.0, 121.0, 118.0, 153.0, 121.0, 156.0, 118.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 171.0, 160.0, 160.0, 162.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 121.0, 75.0, 76.0, 74.0, 75.0, 99.0, 85.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 85.0, 83.0, 119.0, 83.0, 84.0, 127.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 52.0, 52.0, 54.0, 53.0, 55.0, 52.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 65.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 75.0, 75.0, 75.0, 84.0, 76.0, 80.0, 75.0, 82.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 118.0, 122.0, 117.0, 122.0, 121.0, 121.0, 164.0, 122.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 159.0, 157.0, 161.0, 160.0, 161.0, 164.0, 165.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 62.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1485.6, "alertThreshold": 2.0}]} 05:24:41 INFO - Return code: 0 05:24:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:24:41 INFO - # TBPL SUCCESS # 05:24:41 INFO - Running post-action listener: _resource_record_post_action 05:24:41 INFO - ##### 05:24:41 INFO - ##### Finished run-tests step (success) 05:24:41 INFO - ##### 05:24:41 INFO - Running post-run listener: _resource_record_post_run 05:24:41 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 553021440; Read time: 0; Write time: 512592 05:24:41 INFO - TinderboxPrint: CPU usage
13.0% 05:24:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:24:41 INFO - TinderboxPrint: I/O write bytes / time
553,021,440 / 512,592 05:24:41 INFO - TinderboxPrint: CPU idle
8,277.8 (87.0%) 05:24:41 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 05:24:41 INFO - TinderboxPrint: Swap in / out
0 / 0 05:24:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256192512; Read time: 0; Write time: 251040 05:24:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296828928; Read time: 0; Write time: 261552 05:24:42 INFO - Running post-run listener: _upload_blobber_files 05:24:42 INFO - Blob upload gear active. 05:24:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:42 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 05:24:42 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'] 05:24:42 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 05:24:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:45 INFO - (blobuploader) - INFO - Done attempting. 05:24:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:24:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:24:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:46 INFO - (blobuploader) - INFO - Done attempting. 05:24:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:24:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:24:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:47 INFO - (blobuploader) - INFO - Done attempting. 05:24:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:47 INFO - Return code: 0 05:24:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccbff499bb56efd9a1d25e9ce5e531446f58374d5ffbd219ec42198cc852895952aafd71346f3d8f799ba119cba4bfa352e7e0e0214400ee481083d355f59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58da9566a357b75355c74bf5677ab2a649050e9da410192c4d807599c2ad496d347363c2d4c94e5c6fe426327829f33f340c2e2f46d257ebb2ddf49213cf3f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/757b943acc2cb0c040c339b9420a238c7b233d094e6644bea9cb938a530cc6f7b9aaaf52ddc8e479ceddb8b0a012028a187703271433e459df748cb5a58a799c"} 05:24:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:47 INFO - Contents: 05:24:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccbff499bb56efd9a1d25e9ce5e531446f58374d5ffbd219ec42198cc852895952aafd71346f3d8f799ba119cba4bfa352e7e0e0214400ee481083d355f59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58da9566a357b75355c74bf5677ab2a649050e9da410192c4d807599c2ad496d347363c2d4c94e5c6fe426327829f33f340c2e2f46d257ebb2ddf49213cf3f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/757b943acc2cb0c040c339b9420a238c7b233d094e6644bea9cb938a530cc6f7b9aaaf52ddc8e479ceddb8b0a012028a187703271433e459df748cb5a58a799c"} 05:24:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:47 INFO - Copying logs to upload dir... 05:24:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.876422 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-09 05:24:47.158211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 05:24:47.161908) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccbff499bb56efd9a1d25e9ce5e531446f58374d5ffbd219ec42198cc852895952aafd71346f3d8f799ba119cba4bfa352e7e0e0214400ee481083d355f59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58da9566a357b75355c74bf5677ab2a649050e9da410192c4d807599c2ad496d347363c2d4c94e5c6fe426327829f33f340c2e2f46d257ebb2ddf49213cf3f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/757b943acc2cb0c040c339b9420a238c7b233d094e6644bea9cb938a530cc6f7b9aaaf52ddc8e479ceddb8b0a012028a187703271433e459df748cb5a58a799c"} build_url:https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/YPyyWxNSSRaB5keJsPFeVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccbff499bb56efd9a1d25e9ce5e531446f58374d5ffbd219ec42198cc852895952aafd71346f3d8f799ba119cba4bfa352e7e0e0214400ee481083d355f59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58da9566a357b75355c74bf5677ab2a649050e9da410192c4d807599c2ad496d347363c2d4c94e5c6fe426327829f33f340c2e2f46d257ebb2ddf49213cf3f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/757b943acc2cb0c040c339b9420a238c7b233d094e6644bea9cb938a530cc6f7b9aaaf52ddc8e479ceddb8b0a012028a187703271433e459df748cb5a58a799c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 05:24:47.186467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:24:47.186768) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468064600.817376-247428970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 05:24:47.270953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 05:24:47.271222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 05:24:47.271499) ========= ========= Total master_lag: 0.17 =========