builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1470685288.03 results: success (0) buildid: 20160808110954 builduid: be4efc220d63441da662ba188ccc4074 revision: 429d054ed34d2474d5521d89ece0926987068103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.034212) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.034894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.035249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.051322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.051804) ========= 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=0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 12:41:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.4M=0s 2016-08-08 12:41:28 (34.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127597 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.220396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.221020) ========= 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=0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019925 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.278898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.279255) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 429d054ed34d2474d5521d89ece0926987068103 --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 429d054ed34d2474d5521d89ece0926987068103 --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=0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 12:41:28,602 truncating revision to first 12 chars 2016-08-08 12:41:28,602 Setting DEBUG logging. 2016-08-08 12:41:28,602 attempt 1/10 2016-08-08 12:41:28,602 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/429d054ed34d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 12:41:28,912 unpacking tar archive at: fx-team-429d054ed34d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.950595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.950949) ========= script_repo_revision: 429d054ed34d2474d5521d89ece0926987068103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.951446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.951761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 12:41:28.967515) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-08-08 12:41:28.967893) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:41:29 INFO - MultiFileLogger online at 20160808 12:41:29 in /builds/slave/test 12:41:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:41:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:41:29 INFO - {'append_to_log': False, 12:41:29 INFO - 'base_work_dir': '/builds/slave/test', 12:41:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:41:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:41:29 INFO - 'branch': 'Fx-Team-Non-PGO', 12:41:29 INFO - 'buildbot_json_path': 'buildprops.json', 12:41:29 INFO - 'config_files': ('talos/linux_config.py',), 12:41:29 INFO - 'default_actions': ('clobber', 12:41:29 INFO - 'read-buildbot-config', 12:41:29 INFO - 'download-and-extract', 12:41:29 INFO - 'populate-webroot', 12:41:29 INFO - 'create-virtualenv', 12:41:29 INFO - 'install', 12:41:29 INFO - 'run-tests'), 12:41:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:41:29 INFO - 'download_minidump_stackwalk': True, 12:41:29 INFO - 'download_symbols': 'ondemand', 12:41:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:41:29 INFO - 'tooltool.py': '/tools/tooltool.py', 12:41:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:41:29 INFO - '/tools/misc-python/virtualenv.py')}, 12:41:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:41:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:41:29 INFO - 'installer_path': 'installer.exe', 12:41:29 INFO - 'log_level': 'info', 12:41:29 INFO - 'log_name': 'talos', 12:41:29 INFO - 'log_to_console': True, 12:41:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:41:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:41:29 INFO - 'opt_config_files': (), 12:41:29 INFO - 'pip_index': False, 12:41:29 INFO - 'sps_profile': False, 12:41:29 INFO - 'sps_profile_interval': 0, 12:41:29 INFO - 'suite': 'dromaeojs', 12:41:29 INFO - 'system_bits': '32', 12:41:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:41:29 INFO - 'title': 'talos-linux64-ix-017', 12:41:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:41:29 INFO - 'use_talos_json': True, 12:41:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:41:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:41:29 INFO - 'work_dir': 'build'} 12:41:29 INFO - [mozharness: 2016-08-08 19:41:29.384808Z] Running clobber step. 12:41:29 INFO - Running pre-action listener: _resource_record_pre_action 12:41:29 INFO - Running main action method: clobber 12:41:29 INFO - rmtree: /builds/slave/test/build 12:41:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:41:30 INFO - Running post-action listener: _resource_record_post_action 12:41:30 INFO - [mozharness: 2016-08-08 19:41:30.353277Z] Finished clobber step (success) 12:41:30 INFO - [mozharness: 2016-08-08 19:41:30.353377Z] Running read-buildbot-config step. 12:41:30 INFO - Running pre-action listener: _resource_record_pre_action 12:41:30 INFO - Running main action method: read_buildbot_config 12:41:30 INFO - Using buildbot properties: 12:41:30 INFO - { 12:41:30 INFO - "project": "", 12:41:30 INFO - "product": "firefox", 12:41:30 INFO - "script_repo_revision": "production", 12:41:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:41:30 INFO - "repository": "", 12:41:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:41:30 INFO - "buildid": "20160808110954", 12:41:30 INFO - "pgo_build": "False", 12:41:30 INFO - "basedir": "/builds/slave/test", 12:41:30 INFO - "buildnumber": 3223, 12:41:30 INFO - "slavename": "talos-linux64-ix-017", 12:41:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:41:30 INFO - "platform": "ubuntu64_hw", 12:41:30 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 12:41:30 INFO - "branch": "fx-team", 12:41:30 INFO - "repo_path": "integration/fx-team", 12:41:30 INFO - "revision": "429d054ed34d2474d5521d89ece0926987068103", 12:41:30 INFO - "stage_platform": "linux64", 12:41:30 INFO - "builduid": "be4efc220d63441da662ba188ccc4074", 12:41:30 INFO - "slavebuilddir": "test" 12:41:30 INFO - } 12:41:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:41:30 INFO - Running post-action listener: _resource_record_post_action 12:41:30 INFO - [mozharness: 2016-08-08 19:41:30.355808Z] Finished read-buildbot-config step (success) 12:41:30 INFO - [mozharness: 2016-08-08 19:41:30.355897Z] Running download-and-extract step. 12:41:30 INFO - Running pre-action listener: _resource_record_pre_action 12:41:30 INFO - Running main action method: download_and_extract 12:41:30 INFO - mkdir: /builds/slave/test/build/tests 12:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:30 INFO - trying https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:41:30 INFO - Downloaded 1361 bytes. 12:41:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:41:30 INFO - Using the following test package requirements: 12:41:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:41:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:41:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:41:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'jsshell-linux-x86_64.zip'], 12:41:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:41:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:41:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:41:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:41:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:41:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:41:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:30 INFO - trying https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:41:32 INFO - Downloaded 20257787 bytes. 12:41:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:41:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:41:33 INFO - Return code: 0 12:41:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:33 INFO - trying https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:41:33 INFO - Downloading https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:41:34 INFO - Downloaded 20257787 bytes. 12:41:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:41:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:41:36 INFO - Return code: 0 12:41:36 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:36 INFO - trying https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:41:36 INFO - Downloading https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:41:37 INFO - Downloaded 14413723 bytes. 12:41:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:41:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:41:37 INFO - Return code: 0 12:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:37 INFO - trying https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:41:37 INFO - Downloading https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:41:43 INFO - Downloaded 56129966 bytes. 12:41:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:41:43 INFO - mkdir: /builds/slave/test/properties 12:41:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:41:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:41:43 INFO - Contents: 12:41:43 INFO - build_url:https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:41:44 INFO - Running post-action listener: _resource_record_post_action 12:41:44 INFO - Running post-action listener: set_extra_try_arguments 12:41:44 INFO - [mozharness: 2016-08-08 19:41:44.250300Z] Finished download-and-extract step (success) 12:41:44 INFO - [mozharness: 2016-08-08 19:41:44.250534Z] Running populate-webroot step. 12:41:44 INFO - Running pre-action listener: _resource_record_pre_action 12:41:44 INFO - Running main action method: populate_webroot 12:41:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:41:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:41:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:41:44 INFO - '--tppagecycles', 12:41:44 INFO - '7'], 12:41:44 INFO - 'tests': ['tsvgm']}}, 12:41:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:41:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:41:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:41:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:41:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:41:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:41:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['damp', 'tps']}, 12:41:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'tests': ['damp', 'tps']}, 12:41:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['dromaeo_dom']}, 12:41:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:41:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['basic_compositor_video']}, 12:41:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:41:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['a11yr', 12:41:44 INFO - 'ts_paint', 12:41:44 INFO - 'tpaint', 12:41:44 INFO - 'sessionrestore', 12:41:44 INFO - 'sessionrestore_no_auto_restore', 12:41:44 INFO - 'tabpaint']}, 12:41:44 INFO - 'other-e10s': {'tests': ['a11yr', 12:41:44 INFO - 'ts_paint', 12:41:44 INFO - 'tpaint', 12:41:44 INFO - 'sessionrestore', 12:41:44 INFO - 'sessionrestore_no_auto_restore', 12:41:44 INFO - 'tabpaint']}, 12:41:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:41:44 INFO - 'ts_paint', 12:41:44 INFO - 'tpaint', 12:41:44 INFO - 'sessionrestore', 12:41:44 INFO - 'sessionrestore_no_auto_restore', 12:41:44 INFO - 'tabpaint']}, 12:41:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:41:44 INFO - 'ts_paint', 12:41:44 INFO - 'tpaint', 12:41:44 INFO - 'sessionrestore', 12:41:44 INFO - 'sessionrestore_no_auto_restore', 12:41:44 INFO - 'tabpaint']}, 12:41:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['a11yr', 12:41:44 INFO - 'ts_paint', 12:41:44 INFO - 'tpaint', 12:41:44 INFO - 'sessionrestore', 12:41:44 INFO - 'sessionrestore_no_auto_restore', 12:41:44 INFO - 'tabpaint']}, 12:41:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['a11yr', 12:41:44 INFO - 'ts_paint', 12:41:44 INFO - 'tpaint', 12:41:44 INFO - 'sessionrestore', 12:41:44 INFO - 'sessionrestore_no_auto_restore', 12:41:44 INFO - 'tabpaint']}, 12:41:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['tsvgx', 12:41:44 INFO - 'tsvgr_opacity', 12:41:44 INFO - 'tart', 12:41:44 INFO - 'tscrollx', 12:41:44 INFO - 'cart']}, 12:41:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:41:44 INFO - 'tsvgr_opacity', 12:41:44 INFO - 'tart', 12:41:44 INFO - 'tscrollx', 12:41:44 INFO - 'cart']}, 12:41:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'talos_options': ['--disable-e10s'], 12:41:44 INFO - 'tests': ['tp5o']}, 12:41:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'tests': ['tp5o']}, 12:41:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'talos_options': ['--disable-e10s', 12:41:44 INFO - '--xperf_path', 12:41:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:41:44 INFO - 'tests': ['tp5n']}, 12:41:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:44 INFO - 'talos_options': ['--xperf_path', 12:41:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:41:44 INFO - 'tests': ['tp5n']}}, 12:41:44 INFO - 'talos.zip': {'path': '', 12:41:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:41:44 INFO - Running post-action listener: _resource_record_post_action 12:41:44 INFO - [mozharness: 2016-08-08 19:41:44.273066Z] Finished populate-webroot step (success) 12:41:44 INFO - [mozharness: 2016-08-08 19:41:44.273156Z] Running create-virtualenv step. 12:41:44 INFO - Running pre-action listener: _resource_record_pre_action 12:41:44 INFO - Running main action method: create_virtualenv 12:41:44 INFO - Creating virtualenv /builds/slave/test/build/venv 12:41:44 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 12:41:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:41:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:41:44 INFO - Using real prefix '/usr' 12:41:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:41:44 INFO - Installing distribute.............................................................................................................................................................................................done. 12:41:46 INFO - Installing pip.................done. 12:41:46 INFO - Return code: 0 12:41:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:41:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:46 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 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:41:46 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 12:41:46 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 12:41:46 INFO - Using env: {'DISPLAY': ':0', 12:41:46 INFO - 'HOME': '/home/cltbld', 12:41:46 INFO - 'LANG': 'en_US.UTF-8', 12:41:46 INFO - 'LANGUAGE': 'en_US:en', 12:41:46 INFO - 'LOGNAME': 'cltbld', 12:41:46 INFO - 'MAIL': '/var/mail/cltbld', 12:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:46 INFO - 'MOZ_NO_REMOTE': '1', 12:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:46 INFO - 'NO_EM_RESTART': '1', 12:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:46 INFO - 'PWD': '/builds/slave/test', 12:41:46 INFO - 'SHELL': '/bin/bash', 12:41:46 INFO - 'SHLVL': '1', 12:41:46 INFO - 'TERM': 'linux', 12:41:46 INFO - 'TMOUT': '86400', 12:41:46 INFO - 'USER': 'cltbld', 12:41:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:46 INFO - '_': '/tools/buildbot/bin/python'} 12:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:47 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 12:41:47 INFO - Cleaning up... 12:41:47 INFO - Return code: 0 12:41:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:47 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 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:41:47 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 12:41:47 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 12:41:47 INFO - Using env: {'DISPLAY': ':0', 12:41:47 INFO - 'HOME': '/home/cltbld', 12:41:47 INFO - 'LANG': 'en_US.UTF-8', 12:41:47 INFO - 'LANGUAGE': 'en_US:en', 12:41:47 INFO - 'LOGNAME': 'cltbld', 12:41:47 INFO - 'MAIL': '/var/mail/cltbld', 12:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:47 INFO - 'MOZ_NO_REMOTE': '1', 12:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:47 INFO - 'NO_EM_RESTART': '1', 12:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:47 INFO - 'PWD': '/builds/slave/test', 12:41:47 INFO - 'SHELL': '/bin/bash', 12:41:47 INFO - 'SHLVL': '1', 12:41:47 INFO - 'TERM': 'linux', 12:41:47 INFO - 'TMOUT': '86400', 12:41:47 INFO - 'USER': 'cltbld', 12:41:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:47 INFO - '_': '/tools/buildbot/bin/python'} 12:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:47 INFO - Downloading/unpacking psutil>=3.1.1 12:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:41:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:41:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:41:49 INFO - Installing collected packages: psutil 12:41:49 INFO - Running setup.py install for psutil 12:41:49 INFO - building 'psutil._psutil_linux' extension 12:41:49 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 12:41:49 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 12:41:49 INFO - building 'psutil._psutil_posix' extension 12:41:49 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 12:41:49 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 12:41:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:41:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:41:49 INFO - Successfully installed psutil 12:41:49 INFO - Cleaning up... 12:41:49 INFO - Return code: 0 12:41:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:41: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:41: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 mozsystemmonitor==0.3 12:41:49 INFO - Using env: {'DISPLAY': ':0', 12:41:49 INFO - 'HOME': '/home/cltbld', 12:41:49 INFO - 'LANG': 'en_US.UTF-8', 12:41:49 INFO - 'LANGUAGE': 'en_US:en', 12:41:49 INFO - 'LOGNAME': 'cltbld', 12:41:49 INFO - 'MAIL': '/var/mail/cltbld', 12:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:49 INFO - 'MOZ_NO_REMOTE': '1', 12:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:49 INFO - 'NO_EM_RESTART': '1', 12:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:49 INFO - 'PWD': '/builds/slave/test', 12:41:49 INFO - 'SHELL': '/bin/bash', 12:41:49 INFO - 'SHLVL': '1', 12:41:49 INFO - 'TERM': 'linux', 12:41:49 INFO - 'TMOUT': '86400', 12:41:49 INFO - 'USER': 'cltbld', 12:41:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:49 INFO - '_': '/tools/buildbot/bin/python'} 12:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:41:51 INFO - Installing collected packages: mozsystemmonitor 12:41:51 INFO - Running setup.py install for mozsystemmonitor 12:41:52 INFO - Successfully installed mozsystemmonitor 12:41:52 INFO - Cleaning up... 12:41:52 INFO - Return code: 0 12:41:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:41:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:41:52 INFO - Using env: {'DISPLAY': ':0', 12:41:52 INFO - 'HOME': '/home/cltbld', 12:41:52 INFO - 'LANG': 'en_US.UTF-8', 12:41:52 INFO - 'LANGUAGE': 'en_US:en', 12:41:52 INFO - 'LOGNAME': 'cltbld', 12:41:52 INFO - 'MAIL': '/var/mail/cltbld', 12:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:52 INFO - 'MOZ_NO_REMOTE': '1', 12:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:52 INFO - 'NO_EM_RESTART': '1', 12:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:52 INFO - 'PWD': '/builds/slave/test', 12:41:52 INFO - 'SHELL': '/bin/bash', 12:41:52 INFO - 'SHLVL': '1', 12:41:52 INFO - 'TERM': 'linux', 12:41:52 INFO - 'TMOUT': '86400', 12:41:52 INFO - 'USER': 'cltbld', 12:41:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:52 INFO - '_': '/tools/buildbot/bin/python'} 12:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:52 INFO - Downloading/unpacking jsonschema==2.5.1 12:41:52 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 12:41:52 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 12:41:52 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 12:41:52 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 12:41:52 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 12:41:52 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 12:41:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:41:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:41:55 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 12:41:55 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 12:41:55 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 12:41:55 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 12:41:55 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 12:41:55 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 12:41:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:41:55 INFO - warning: no files found matching '*.txt' 12:41:55 INFO - no previously-included directories found matching 'build' 12:41:55 INFO - no previously-included directories found matching 'dist' 12:41:55 INFO - no previously-included directories found matching '.git*' 12:41:55 INFO - Installing collected packages: jsonschema, functools32 12:41:55 INFO - Running setup.py install for functools32 12:41:56 INFO - warning: no files found matching '*.txt' 12:41:56 INFO - no previously-included directories found matching 'build' 12:41:56 INFO - no previously-included directories found matching 'dist' 12:41:56 INFO - no previously-included directories found matching '.git*' 12:41:56 INFO - Successfully installed jsonschema functools32 12:41:56 INFO - Cleaning up... 12:41:56 INFO - Return code: 0 12:41:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:41:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:41:56 INFO - Using env: {'DISPLAY': ':0', 12:41:56 INFO - 'HOME': '/home/cltbld', 12:41:56 INFO - 'LANG': 'en_US.UTF-8', 12:41:56 INFO - 'LANGUAGE': 'en_US:en', 12:41:56 INFO - 'LOGNAME': 'cltbld', 12:41:56 INFO - 'MAIL': '/var/mail/cltbld', 12:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:56 INFO - 'MOZ_NO_REMOTE': '1', 12:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:56 INFO - 'NO_EM_RESTART': '1', 12:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:56 INFO - 'PWD': '/builds/slave/test', 12:41:56 INFO - 'SHELL': '/bin/bash', 12:41:56 INFO - 'SHLVL': '1', 12:41:56 INFO - 'TERM': 'linux', 12:41:56 INFO - 'TMOUT': '86400', 12:41:56 INFO - 'USER': 'cltbld', 12:41:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:56 INFO - '_': '/tools/buildbot/bin/python'} 12:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:41:56 INFO - Cleaning up... 12:41:56 INFO - Return code: 0 12:41:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:41:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:41:56 INFO - Using env: {'DISPLAY': ':0', 12:41:56 INFO - 'HOME': '/home/cltbld', 12:41:56 INFO - 'LANG': 'en_US.UTF-8', 12:41:56 INFO - 'LANGUAGE': 'en_US:en', 12:41:56 INFO - 'LOGNAME': 'cltbld', 12:41:56 INFO - 'MAIL': '/var/mail/cltbld', 12:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:56 INFO - 'MOZ_NO_REMOTE': '1', 12:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:56 INFO - 'NO_EM_RESTART': '1', 12:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:56 INFO - 'PWD': '/builds/slave/test', 12:41:56 INFO - 'SHELL': '/bin/bash', 12:41:56 INFO - 'SHLVL': '1', 12:41:56 INFO - 'TERM': 'linux', 12:41:56 INFO - 'TMOUT': '86400', 12:41:56 INFO - 'USER': 'cltbld', 12:41:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:56 INFO - '_': '/tools/buildbot/bin/python'} 12:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:58 INFO - Downloading blobuploader-1.2.4.tar.gz 12:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:41:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:41:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:41:59 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 12:41:59 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 12:41:59 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 12:41:59 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 12:41:59 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 12:41:59 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 12:41:59 INFO - Downloading docopt-0.6.1.tar.gz 12:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:41:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:41:59 INFO - Running setup.py install for blobuploader 12:41:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:41:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:41:59 INFO - Running setup.py install for requests 12:41:59 INFO - Running setup.py install for docopt 12:41:59 INFO - Successfully installed blobuploader requests docopt 12:41:59 INFO - Cleaning up... 12:41:59 INFO - Return code: 0 12:41:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:59 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 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:41:59 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 12:41:59 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 12:41:59 INFO - Using env: {'DISPLAY': ':0', 12:41:59 INFO - 'HOME': '/home/cltbld', 12:41:59 INFO - 'LANG': 'en_US.UTF-8', 12:41:59 INFO - 'LANGUAGE': 'en_US:en', 12:41:59 INFO - 'LOGNAME': 'cltbld', 12:41:59 INFO - 'MAIL': '/var/mail/cltbld', 12:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:59 INFO - 'MOZ_NO_REMOTE': '1', 12:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:41:59 INFO - 'NO_EM_RESTART': '1', 12:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:59 INFO - 'PWD': '/builds/slave/test', 12:41:59 INFO - 'SHELL': '/bin/bash', 12:41:59 INFO - 'SHLVL': '1', 12:41:59 INFO - 'TERM': 'linux', 12:41:59 INFO - 'TMOUT': '86400', 12:41:59 INFO - 'USER': 'cltbld', 12:41:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:59 INFO - '_': '/tools/buildbot/bin/python'} 12:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:00 INFO - Running setup.py (path:/tmp/pip-Htv0Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:00 INFO - Running setup.py (path:/tmp/pip-qPHxCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:00 INFO - Running setup.py (path:/tmp/pip-Iwc_XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:00 INFO - Running setup.py (path:/tmp/pip-lxfMS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:00 INFO - Running setup.py (path:/tmp/pip-k6Fq_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:00 INFO - Running setup.py (path:/tmp/pip-7Rin55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:00 INFO - Running setup.py (path:/tmp/pip-_3HkGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:00 INFO - Running setup.py (path:/tmp/pip-5H7YBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:00 INFO - Running setup.py (path:/tmp/pip-ROwxfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:00 INFO - Running setup.py (path:/tmp/pip-QHB5FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:00 INFO - Running setup.py (path:/tmp/pip-5g9N5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:01 INFO - Running setup.py (path:/tmp/pip-4HSFXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:01 INFO - Running setup.py (path:/tmp/pip-6JjzfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:01 INFO - Running setup.py (path:/tmp/pip-iTb01v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:01 INFO - Running setup.py (path:/tmp/pip-MfNkkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:01 INFO - Running setup.py (path:/tmp/pip-KdDTjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:01 INFO - Running setup.py (path:/tmp/pip-xpp5JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:42:01 INFO - Running setup.py install for manifestparser 12:42:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:42:01 INFO - Running setup.py install for mozcrash 12:42:01 INFO - Running setup.py install for mozdebug 12:42:01 INFO - Running setup.py install for mozdevice 12:42:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:42:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:42:01 INFO - Running setup.py install for mozfile 12:42:01 INFO - Running setup.py install for mozhttpd 12:42:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Running setup.py install for mozinfo 12:42:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Running setup.py install for mozInstall 12:42:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Running setup.py install for mozleak 12:42:02 INFO - Running setup.py install for mozlog 12:42:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Running setup.py install for moznetwork 12:42:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Running setup.py install for mozprocess 12:42:02 INFO - Running setup.py install for mozprofile 12:42:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Running setup.py install for mozrunner 12:42:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:42:02 INFO - Running setup.py install for mozscreenshot 12:42:03 INFO - Running setup.py install for moztest 12:42:03 INFO - Running setup.py install for mozversion 12:42:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:42:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:42:03 INFO - Cleaning up... 12:42:03 INFO - Return code: 0 12:42:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:03 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 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:42:03 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 12:42:03 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 12:42:03 INFO - Using env: {'DISPLAY': ':0', 12:42:03 INFO - 'HOME': '/home/cltbld', 12:42:03 INFO - 'LANG': 'en_US.UTF-8', 12:42:03 INFO - 'LANGUAGE': 'en_US:en', 12:42:03 INFO - 'LOGNAME': 'cltbld', 12:42:03 INFO - 'MAIL': '/var/mail/cltbld', 12:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:03 INFO - 'MOZ_NO_REMOTE': '1', 12:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:03 INFO - 'NO_EM_RESTART': '1', 12:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:03 INFO - 'PWD': '/builds/slave/test', 12:42:03 INFO - 'SHELL': '/bin/bash', 12:42:03 INFO - 'SHLVL': '1', 12:42:03 INFO - 'TERM': 'linux', 12:42:03 INFO - 'TMOUT': '86400', 12:42:03 INFO - 'USER': 'cltbld', 12:42:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:03 INFO - '_': '/tools/buildbot/bin/python'} 12:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:03 INFO - Running setup.py (path:/tmp/pip-0cyl9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:03 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)) 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:03 INFO - Running setup.py (path:/tmp/pip-Ph31OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:03 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)) 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:03 INFO - Running setup.py (path:/tmp/pip-dhn61H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:03 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)) 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:03 INFO - Running setup.py (path:/tmp/pip-651GWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:03 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)) 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:03 INFO - Running setup.py (path:/tmp/pip-XlFWUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:03 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)) 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:03 INFO - Running setup.py (path:/tmp/pip-5UMM80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:03 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)) 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:03 INFO - Running setup.py (path:/tmp/pip-HH6y_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:03 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)) 12:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:03 INFO - Running setup.py (path:/tmp/pip-V0OEnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:04 INFO - Running setup.py (path:/tmp/pip-Yaxznt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:04 INFO - Running setup.py (path:/tmp/pip-xazhYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:04 INFO - Running setup.py (path:/tmp/pip-Mk2Kf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:04 INFO - Running setup.py (path:/tmp/pip-3ycscp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:04 INFO - Running setup.py (path:/tmp/pip-KWzZ8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:04 INFO - Running setup.py (path:/tmp/pip-sZPp2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:04 INFO - Running setup.py (path:/tmp/pip-PbX8u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:04 INFO - Running setup.py (path:/tmp/pip-UtDnPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:04 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)) 12:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:04 INFO - Running setup.py (path:/tmp/pip-QLvklt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:04 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)) 12:42:04 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)) 12:42:04 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)) 12:42:04 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)) 12:42:04 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)) 12:42:04 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)) 12:42:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:42:04 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 12:42:04 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 12:42:04 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 12:42:04 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 12:42:04 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 12:42:04 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 12:42:06 INFO - Downloading blessings-1.6.tar.gz 12:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:42:06 INFO - Installing collected packages: blessings 12:42:06 INFO - Running setup.py install for blessings 12:42:07 INFO - Successfully installed blessings 12:42:07 INFO - Cleaning up... 12:42:07 INFO - Return code: 0 12:42:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:42:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:07 INFO - Reading from file tmpfile_stdout 12:42:07 INFO - Current package versions: 12:42:07 INFO - argparse == 1.2.1 12:42:07 INFO - blessings == 1.6 12:42:07 INFO - blobuploader == 1.2.4 12:42:07 INFO - docopt == 0.6.1 12:42:07 INFO - functools32 == 3.2.3-2 12:42:07 INFO - jsonschema == 2.5.1 12:42:07 INFO - manifestparser == 1.1 12:42:07 INFO - mozInstall == 1.12 12:42:07 INFO - mozcrash == 0.17 12:42:07 INFO - mozdebug == 0.1 12:42:07 INFO - mozdevice == 0.48 12:42:07 INFO - mozfile == 1.2 12:42:07 INFO - mozhttpd == 0.7 12:42:07 INFO - mozinfo == 0.9 12:42:07 INFO - mozleak == 0.1 12:42:07 INFO - mozlog == 3.3 12:42:07 INFO - moznetwork == 0.27 12:42:07 INFO - mozprocess == 0.23 12:42:07 INFO - mozprofile == 0.28 12:42:07 INFO - mozrunner == 6.12 12:42:07 INFO - mozscreenshot == 0.1 12:42:07 INFO - mozsystemmonitor == 0.3 12:42:07 INFO - moztest == 0.7 12:42:07 INFO - mozversion == 1.4 12:42:07 INFO - psutil == 3.1.1 12:42:07 INFO - requests == 1.2.3 12:42:07 INFO - wsgiref == 0.1.2 12:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:07 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 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:42:07 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 12:42:07 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 12:42:07 INFO - Using env: {'DISPLAY': ':0', 12:42:07 INFO - 'HOME': '/home/cltbld', 12:42:07 INFO - 'LANG': 'en_US.UTF-8', 12:42:07 INFO - 'LANGUAGE': 'en_US:en', 12:42:07 INFO - 'LOGNAME': 'cltbld', 12:42:07 INFO - 'MAIL': '/var/mail/cltbld', 12:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:07 INFO - 'MOZ_NO_REMOTE': '1', 12:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:07 INFO - 'NO_EM_RESTART': '1', 12:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:07 INFO - 'PWD': '/builds/slave/test', 12:42:07 INFO - 'SHELL': '/bin/bash', 12:42:07 INFO - 'SHLVL': '1', 12:42:07 INFO - 'TERM': 'linux', 12:42:07 INFO - 'TMOUT': '86400', 12:42:07 INFO - 'USER': 'cltbld', 12:42:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:07 INFO - '_': '/tools/buildbot/bin/python'} 12:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 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)) 12:42:07 INFO - Cleaning up... 12:42:07 INFO - Return code: 0 12:42:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2395030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2656180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, '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': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', '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 12:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:42:07 INFO - Using env: {'DISPLAY': ':0', 12:42:07 INFO - 'HOME': '/home/cltbld', 12:42:07 INFO - 'LANG': 'en_US.UTF-8', 12:42:07 INFO - 'LANGUAGE': 'en_US:en', 12:42:07 INFO - 'LOGNAME': 'cltbld', 12:42:07 INFO - 'MAIL': '/var/mail/cltbld', 12:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:07 INFO - 'MOZ_NO_REMOTE': '1', 12:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:07 INFO - 'NO_EM_RESTART': '1', 12:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:07 INFO - 'PWD': '/builds/slave/test', 12:42:07 INFO - 'SHELL': '/bin/bash', 12:42:07 INFO - 'SHLVL': '1', 12:42:07 INFO - 'TERM': 'linux', 12:42:07 INFO - 'TMOUT': '86400', 12:42:07 INFO - 'USER': 'cltbld', 12:42:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:07 INFO - '_': '/tools/buildbot/bin/python'} 12:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:42:07 INFO - Cleaning up... 12:42:07 INFO - Return code: 0 12:42:07 INFO - Running post-action listener: _resource_record_post_action 12:42:07 INFO - Running post-action listener: _start_resource_monitoring 12:42:07 INFO - Starting resource monitoring. 12:42:07 INFO - [mozharness: 2016-08-08 19:42:07.753550Z] Finished create-virtualenv step (success) 12:42:07 INFO - [mozharness: 2016-08-08 19:42:07.753992Z] Running install step. 12:42:07 INFO - Running pre-action listener: _resource_record_pre_action 12:42:07 INFO - Running main action method: install 12:42:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:07 INFO - Reading from file tmpfile_stdout 12:42:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:42:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:42:08 INFO - Reading from file tmpfile_stdout 12:42:08 INFO - Output received: 12:42:08 INFO - Usage: mozinstall [options] installer 12:42:08 INFO - Options: 12:42:08 INFO - -h, --help show this help message and exit 12:42:08 INFO - -d DEST, --destination=DEST 12:42:08 INFO - Directory to install application into. [default: 12:42:08 INFO - "/builds/slave/test"] 12:42:08 INFO - --app=APP Application being installed. [default: firefox] 12:42:08 INFO - mkdir: /builds/slave/test/build/application 12:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:42:24 INFO - Reading from file tmpfile_stdout 12:42:24 INFO - Output received: 12:42:24 INFO - /builds/slave/test/build/application/firefox/firefox 12:42:24 INFO - Running post-action listener: _resource_record_post_action 12:42:24 INFO - [mozharness: 2016-08-08 19:42:24.233940Z] Finished install step (success) 12:42:24 INFO - [mozharness: 2016-08-08 19:42:24.234186Z] Running run-tests step. 12:42:24 INFO - Running pre-action listener: _resource_record_pre_action 12:42:24 INFO - Running main action method: run_tests 12:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:42:24 INFO - Python 2.7.3 12:42:24 INFO - Return code: 0 12:42:24 INFO - grabbing minidump binary from tooltool 12:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:24 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 0x26543b0>, '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 0x26552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2655740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:42:24 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 12:42:24 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 12:42:24 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 12:42:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:42:24 INFO - Return code: 0 12:42:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:42:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:42:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:42:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:42:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 12:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 12:42:24 INFO - Using env: {'DISPLAY': ':0', 12:42:24 INFO - 'HOME': '/home/cltbld', 12:42:24 INFO - 'LANG': 'en_US.UTF-8', 12:42:24 INFO - 'LANGUAGE': 'en_US:en', 12:42:24 INFO - 'LOGNAME': 'cltbld', 12:42:24 INFO - 'MAIL': '/var/mail/cltbld', 12:42:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:42:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:24 INFO - 'MOZ_NO_REMOTE': '1', 12:42:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:42:24 INFO - 'NO_EM_RESTART': '1', 12:42:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:24 INFO - 'PWD': '/builds/slave/test', 12:42:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:42:24 INFO - 'SHELL': '/bin/bash', 12:42:24 INFO - 'SHLVL': '1', 12:42:24 INFO - 'TERM': 'linux', 12:42:24 INFO - 'TMOUT': '86400', 12:42:24 INFO - 'USER': 'cltbld', 12:42:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836', 12:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:24 INFO - '_': '/tools/buildbot/bin/python'} 12:42:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 12:42:24 INFO - mozversion application_buildid: 20160808110954 12:42:24 INFO - mozversion application_changeset: 429d054ed34d2474d5521d89ece0926987068103 12:42:24 INFO - mozversion application_display_name: Nightly 12:42:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:42:24 INFO - mozversion application_name: Firefox 12:42:24 INFO - mozversion application_remotingname: firefox 12:42:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:42:24 INFO - mozversion application_vendor: Mozilla 12:42:24 INFO - mozversion application_version: 51.0a1 12:42:24 INFO - mozversion platform_buildid: 20160808110954 12:42:24 INFO - mozversion platform_changeset: 429d054ed34d2474d5521d89ece0926987068103 12:42:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:42:24 INFO - mozversion platform_version: 51.0a1 12:42:24 INFO - using testdate: 1470685344 12:42:24 INFO - actual date: 1470685344 12:42:24 INFO - starting webserver on 'localhost:47804' 12:42:24 INFO - SUITE-START | Running 2 tests 12:42:24 INFO - TEST-START | dromaeo_css 12:42:24 INFO - operating with platform_type : linux_ 12:42:24 INFO - Initialising browser for dromaeo_css test... 12:42:24 INFO - TEST-INFO | started process 12116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmcOQ3v/profile http://localhost:47804/getInfo.html) 12:42:28 INFO - PROCESS | 12116 | __metrics Screen width/height:1600/1200 12:42:28 INFO - PROCESS | 12116 | colorDepth:24 12:42:28 INFO - PROCESS | 12116 | Browser inner width/height: 1024/697 12:42:28 INFO - PROCESS | 12116 | __metrics 12:42:29 INFO - PROCESS | 12116 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:42:29 INFO - PROCESS | 12116 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:42:30 INFO - TEST-INFO | 12116: exit 0 12:42:30 INFO - Browser initialized. 12:42:30 INFO - Running cycle 1/1 for dromaeo_css test... 12:42:30 INFO - TEST-INFO | started process 12198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmcOQ3v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:42 INFO - PROCESS | 12198 | RSS: Main: 157732864 12:42:42 INFO - PROCESS | 12198 | 12:43:34 INFO - PROCESS | 12198 | 1470685414313 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] 12:45:46 INFO - PROCESS | 12198 | Cycle 1(1): loaded http://localhost:47804/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47804/tests/dromaeo/cssquery-ext.html) 12:45:47 INFO - PROCESS | 12198 | RSS: Main: 238436352 12:45:47 INFO - PROCESS | 12198 | 12:48:49 INFO - PROCESS | 12198 | Cycle 1(1): loaded http://localhost:47804/tests/dromaeo/cssquery-ext.html (next: http://localhost:47804/tests/dromaeo/cssquery-jquery.html) 12:48:50 INFO - PROCESS | 12198 | RSS: Main: 245596160 12:48:50 INFO - PROCESS | 12198 | 12:51:52 INFO - PROCESS | 12198 | Cycle 1(1): loaded http://localhost:47804/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47804/tests/dromaeo/cssquery-mootools.html) 12:51:53 INFO - PROCESS | 12198 | RSS: Main: 190939136 12:51:53 INFO - PROCESS | 12198 | 12:54:55 INFO - PROCESS | 12198 | Cycle 1(1): loaded http://localhost:47804/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47804/tests/dromaeo/cssquery-prototype.html) 12:54:56 INFO - PROCESS | 12198 | RSS: Main: 189227008 12:54:56 INFO - PROCESS | 12198 | 12:57:59 INFO - PROCESS | 12198 | Cycle 1(1): loaded http://localhost:47804/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47804/tests/dromaeo/cssquery-yui.html) 12:57:59 INFO - PROCESS | 12198 | RSS: Main: 189820928 12:57:59 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | Cycle 1(1): loaded http://localhost:47804/tests/dromaeo/cssquery-yui.html (next: http://localhost:47804/tests/dromaeo/cssquery-dojo.html) 13:01:02 INFO - PROCESS | 12198 | RSS: Main: 281767936 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | __start_tp_report 13:01:02 INFO - PROCESS | 12198 | _x_x_mozilla_page_load 13:01:02 INFO - PROCESS | 12198 | _x_x_mozilla_page_load_details 13:01:02 INFO - PROCESS | 12198 | |i|pagename|runs| 13:01:02 INFO - PROCESS | 12198 | |0;dojo.html;2587.236765154282;2592.22233330001;2612.0988259050628;2625.396158883457;2632.670916135483;4448.666350023745;4504.099180163972;4616.307553866922;4619.930701039487;4633.791479383423;4559.202139625569;4645.279981602848;4685.2737825637;4721.952780472194;4738.194506933821;4247.723897946639;4272.764997925113;4281.272183728765;4298.032942587924;4354.804033818486;4181.665466762652;4343.153085148398;4376.363256078011;4383.802728877208;4421.226285400042;4170.749755014709;4207.200631879933;4211.620954114113;4326.891827704301;4368.89077773055;4278.080212754242;4318.848840290575;4335.458067741532;4354.455693038371;4389.495208051083;4283.614474697261;4308.052228509723;4310.547392523771;4350.8042138103865;4358.259095953696;4388.802503887333;4706.482286948433;4722.031983443386;4746.501617330199;4754.477007529169;4887.0714564232685;4910.288008238786;4928.556429921288;5017.096922553938;5018.548330650259;5036.017976494585;5039.294498770175;5045.268436076785;5051.065552872694;5052.065367906949;4641.651876109306;4687.62499000086;4693.342931989524;4695.976520117446;4698.647601429906;4959.2809042688605;5098.566621837185;5131.923021154686;5132.9743351283005;5173.5602473789395;4970.776315065831;5015.448300686921;5020.49795020495;5021;5025.748712564357;5045.217991211368;5049.873753156127;5081.136206844845;5094.286799848024;5103.515166059218;4756.167670657621;4986.850394488099;5003.449620541737;5067.5185857343495;5069.112905241568;5010.073136469765;5027.095122877917;5031.74841257943;5035.446100928895;5065.316182315414;4269.829206831754;4308.030693094029;4309.633681137138;4339.1104823511105;4352.73883566987;3634.182308980511;3647.252313275772;3697.6672099511175;3712.7401081924545;3737.9065523362133;4314.913701726011;4318.330658747899;4345.304751239786;4350.260455722535;4362.956370436318;5031.144705400091;5036.11867923112;5041.722705251246;5042.899142017212;5076.6192535559985;4181.707280490397;4235.8729238122905;4270.530241673413;4290.82836686529;4344.804483798237;4528.954710452919;4533.659975501784;4547.886302842456;4588.357629931812;4608.953910460852;4757.371083916969;4772.308015337826;4774.283857421415;4777.522247775195;4824.855254342376;4844.975775121102;4994.575461085703;5060.038592667382;5081.4664460232625;5092.388913330424;4737.857864264078;4775.761211939459;4777.689450185866;4801.087793319258;4820.807167713252;4976.552110310089;4982.925256121089;4983.25251212321;4993.650444468853;5033.320501732219;4771.427428708577;4926.433460152129;5040.521150490697;5049.217371307306;5101.974490127525;4811.542903424169;4853.6602437829015;4875.439324477588;4900.730459824744;4916.016796640614;4860.465348811557;4872.585830204331;4874.098291816025;4874.488178741181;4923.65534412602;4634.513376095596;4805.951940480551;4812.735299558558;4862.610991120772;4864.805407783649;4893.363862697969;4931.0630980113665;4960.404751429852;4997.325361076353;5006.7246301452315;4846.151923413318;4853.635977301646;4853.975730121327;4856.830010949741;4909.288153217692 13:01:02 INFO - PROCESS | 12198 | |1;ext.html;570.9543236541076;578.7164289498147;587.5270407322107;593.7120496559165;601.563866197007;29026.85486572567;32070.839645801796;32143.19642008951;39715.60284397155;40736.59263407373;41125.17749645013;41568.16863662725;41617.583824161746;41725.7913710431;41763.79118104405;7645.847083058336;7769.922300777004;7778.49439786412;7779.572123533203;7783.766487005399;7672.578008209574;7742.612869356538;7755.302022817945;7756.224377562255;7759.6508157132785;7760.883586746203;7794.688212471494;7811.609419529029;7813.570253636048;7817.648205830723;7718.112417072024;7745.1093124290865;7758.612069396536;7759.612019399064;7760.107587627383;7688.34649054831;7739.148693643695;7745.883811742829;7758.14660387357;7763.146053934062;39098.21803563941;39441.605583944365;39488.21023579512;39529.40705889414;39559.40660890089;3070.9385812283854;3202.1834432219866;3211.3898359311656;3270.133414645121;3628.3468975584383;28922.566161507384;28997.855010724812;29241.491021077392;29420.411591768257;30711;3248.5127230915314;3260.7228385587255;3272.181954511372;3284.1953721338186;3354.714849237818;249819;250453;250745;251142.74428627922;251539;52446.590971586724;52618;52752;52766.73616631892;52783;32671.673283267337;33891.15272118217;33921.32157356839;35810.8209458951;35862.282754344764;12941.805872911913;12971.41628626714;12984.480620775252;13004.154729942524;13022.088453808332;9958.701238962843;9974.850377244347;10019.549120289605;10032.247581431422;10055.346402483816;18250.45248642516;18250.90874545619;18302.08489575516;18365.632687346177;18365.7245141323;6662.900056499157;6678.699458524378;6700.597964122168;6728.635682158921;6804.353586409283;844.2950136635977;890.2166093837382;971.0338213477635;1002.1331548210745;1005.4821766790109;26558.6016209757;27071.593926091125;27280.590791138147;27677.584836227474;27807.58288625672;851.3870013590205;949.4635530925005;969.9418034917786;1010.0505524806658;1042.3485321673954;13937.303134843218;14514.570563546973;14966.476173333882;15054.654354878961;15108.924455377653;377694;379340;380187;381486;381487;47968.760156198994;48296;48325.275120873215;48341.5165848337;48388.403101705284;1088.8911108889047;1158.79141754485;1185.1348515583672;1207.7886369885412;1213.6419756171952;28293;29105;29358;29614.703852961196;30227.546586801654;42725.14549708926;43229.783851080545;43236;43240.13519729525;43277.35083973806;299749;301681;302427;303123;388009;35149.64850351464;38563;38589.42115868208;38769.6123038766;38859;41781.37327940023;41908.58091419047;41952;42041.57958420377;42126;33514.16214594557;33672.831635842645;33714.494282586274;33723.83138084294;33868.32263354769;33000.66999330072;33280.833595831864;33675.494867577494;33725;34142.487862682574;35984.28031439409;36575.45136823003;36687.63312366842;36961;37240.25519489649;29821.552676709434;30736.385272294876;31910.84044579762;32001.519977200827;32188;25432.237032889043;25586.976520938955;25875.45040655243;25922.74077259203;26239.081632142785 13:01:02 INFO - PROCESS | 12198 | |2;jquery.html;326.47111679079893;350.1037344398339;355.236242079529;355.40824527162266;372.69066674660036;12772.616821495358;13291.93354033231;13812.93093534532;16197.514074577752;16282.185890705447;16672.66654666906;16673.91663041686;17367.652646947052;17527.12364381782;17534.386296479624;4995.725235112068;5042.369703787018;5206.062908676437;5239.921401178985;5311.203319502067;3412.778169418992;5195.350581177353;5205.245239440279;5214.713190774506;5244.895102097956;3563.964360356389;4756.215224487955;6020.789272375468;6082.391760823904;6084.330723620398;5708.77164913403;6051.576389652726;6055.394460553954;6062.484688801457;6062.605930614518;5061.949380506221;5076.086304465195;5078.085944529983;5078.847634570931;5082.3138876251605;11376.317420954769;11386;11432.71418214543;11447.141464390204;11544.76910461786;1771.9153396253482;1893.1386219270198;1901.5246188452886;1922.7404300419405;1939.146775418811;8411.705590304371;8468.745937621881;8884.555772211364;9044.683436079771;9243.953780231055;1639.5655151384892;1696.2282161616436;1696.567375319298;1725.965480690379;1811.5561687386544;59821;68987.65506172487;70482.29517704809;70613;71963.28036719619;9257.583408746623;9344.719658410258;9640.373375730554;9698.078682525149;9756.512174391251;12856;12904;12933.288669123289;12934.159279646792;12969.870301297055;6419.358064193543;6633.701483433257;6634.104395906587;6691.76578819739;6735.663216839139;6084.11780291864;6101.481374083164;6227.1282020516255;6255.280642726054;6257.78097766576;3988.780617066031;4091.1204091120553;4105.4252404663375;4186.1418409226035;4210.915781684349;1645.9012459252244;1654.3051918194387;1685.2079522624347;1716.1333526569003;1746.2840235503384;765.8468306338643;847.4999750147442;908.2143945487106;909.1726528858707;965.0735294117585;16300.836991629933;16447.424340148038;17108.914455427894;17159.227834747468;17318.740218896728;817.7710241132493;832.6586099699094;846.9026062002825;848.8344772769251;862.0991064337782;9174.403663761834;9427.292953028413;9489.620415183454;9551.949285578581;9755.463449510204;380304;381385;383676;385547;388449;73856;74069.6296518514;75127;75466;77931;837.1670188162817;861.3970220845433;877.8727084572702;887.6405055952349;891.9375643704878;15650.608734781721;15791.68416631684;16165.4342098026;16200.189990500663;16321.510354689379;40426.1914761709;40692.389614156404;40922.79538602288;41136;41395.379069314586;54533.45466545284;54698;55404.44595553993;55769.44230557805;55789.442105578426;4914.5822605078965;6941.924001779732;7203.703333399829;7574.545527268381;7681.9231807683445;8047.597620118853;11575.826362604399;11698.181127321346;11827.17209795306;12242;9720.270979676694;9756.756081097745;10452.68641940743;10938.945305273422;11057.447127643747;9683.709488715349;9870.901290987285;10017.198624110199;10049.849252261076;10095;10196.4391958443;10337.84493232587;10497.52761125736;10828.566857325619;11213.046891014355;7082.3979961703835;7115.6086415247655;7157;7223.133224012942;7458.216887226763;9732.464714440774;10405.115565176742;10460.68617941463;10752.086072683596;10799.244052916534 13:01:02 INFO - PROCESS | 12198 | |3;mootools.html;1264.8166015927698;1367.2821768571498;1414.6109819799558;1481.3926290221004;1681.025005496812;6236.314005459396;7373;7615.048118985127;7662.080550333953;7849.136594974562;7675.539467631946;7732.188120247363;7737.535747855119;7751.922480775204;7753.496022758517;2175.5431359414542;2201.5376770878056;2202.933911982635;2203.4050806282294;2206.1947389202987;2112.4718820294925;2163.0374483354835;2166.5883482138343;2167.1873047607146;2169.902354394048;2151.3330867431146;2159.3090211132444;2164.718586583742;2165.9350219493363;2198.373463562885;2129.4995676016124;2132.69075983983;2134.967975480369;2136.4872430616697;2136.7329083864515;2069.7826728193622;2127.6702111172795;2132.4562236629718;2134.6050980568643;2135.562209746998;7519.285667861544;7625.542467451915;7633.961830190813;7638.1979892111085;7704.46068775186;4406.911861762779;4556.088782243564;4608.101420223058;4616.146012987608;4618.1687296286655;2734;2813.212300555848;2876.194665493644;2881.1644623059287;2881.6109825173544;902.4585248850638;909.8544232922767;916.0473107967706;920.6087412849579;930.2557953637063;10058.094771470604;10207.336523125972;10273.640422585173;10365.378077315385;10373.0664240218;3839.3281175794123;4006.358982562776;4155.023569461174;4157.833686652561;4161.292580261303;8851.424657397249;8852.822943541094;8855.247303979106;8860.955695221483;8861.24679402245;4538.228501154812;4540.341650460665;4580.083983203373;4590.495045545054;4595.471520775153;3365.697087262158;3948.506436695413;3988.142549351903;3996.360582306817;4137.027798467358;3571.714262858965;3644.872429465009;3731.589525152231;3742.8315725792404;3751.7748935063983;1109.972250693723;1152.7579208366337;1162.633770362333;1165.143619439711;1165.81929800881;747.3236720767713;797.5015615240475;805.04602046575;817.7138001699358;841.3017195727532;5001.799928002912;5136.43499215086;5174.456682048406;5216;5312.362516497968;835.8829763833069;849.5837039850552;852.2840813716508;879.824035192964;884.4428010353436;3340.1816554943707;3625.818709064536;3656.305301992613;3666.8899933002053;3743.2513497300647;8779.385443018928;8920;9425.151736343762;9427.670031548863;9428.057194280655;9089.409188402733;9375.296852736072;9390.154886060287;9396.67111651089;9410.717678469657;6777.49168812341;6811.352921472452;6987.825304367329;7024.824379390556;7029;5220.582353411642;5266.657667251617;5484.478974497416;5580.609357345109;5586.832395028156;8756.343274254328;8778.209961103532;8805.559722013746;8884.555772211494;8891.866622000805;8647.654093836176;8761.080086590817;8848.734537963872;8944.910550894669;9010;5388.811391601275;5722.799702010409;6546.083548303146;6661.966690166518;6683.365080317362;7231.891521627285;7482.551046937201;7484.962575187089;7485.288897554724;7487.176410594939;6615.536912416084;6641.468682505485;6671.299513551007;6791.932080679328;6798.626075565693;6570.638614876037;6579.407853293226;6617.172853393326;6620.768273110418;6622.503312251697;6176.4441200292185;6223.813285601439;6249.031400132987;6255.53083518747;6264.498840092872;4332.761698106634;4353.259945809284;4422.115576884572;4550.522195169592;4590.196715574828;4392.692511524163;4442.622377097983;4473.888152796206;4544.7500387479;4549.385832912514 13:01:02 INFO - PROCESS | 12198 | |4;prototype.html;285.9928501787455;289.2796935630281;294.49641113695577;298.3495978766289;299.07883718148105;4770.427548694157;4796.664233503656;4808.422989241287;4810.470848206694;4810.494898035704;4714.457837348706;4738.2418812989845;4744.69159504632;4747.715137091777;4754.286856971456;3546.2375589248372;3652.41561350184;3670.4310831820976;3715.071232191952;3740.5137332146783;3724.646158614927;3732.4961130247475;3734.9066273343246;3739.663430291273;3743.737938344317;3686.6313368663054;3709.851605935773;3713.758605690635;3724.5158129443134;3725.882235329404;3538.6461353864665;3574.392353299945;3685.299793039341;3691.151035261878;3691.9446208306895;3191.7446604271604;3216.5979252593424;3238.70851623355;3245.496947973068;3246.756493263015;4481.775911204427;4561.794719237642;4565.908681826378;4583.175028494869;4604.401427814396;3996.220736956295;4202.6847986400835;4211.873643790691;4212.347086201613;4241.130568233505;4951.579115775164;4978.87552811179;4983.302337672692;5002.549770520634;5002.699838009731;3532.876349327761;3553.5202747629255;3576.928461430783;3578.2306804037257;3590.6947909427467;5081.23781432788;5274.92087618686;5296.629235953485;5297.947020529822;5305.442928492491;3615.403458429382;3623.782573045573;3626.5829429615405;3636.7999760012926;3645.453182022718;3684.852605895734;3687.9262414751556;3688.55737311519;3697.815109244581;3709.870154544578;4193.18232944579;4195.181939521825;4207.158568286355;4209;4220.662347012231;4887.36464259644;4985.740044253347;5009.974950125226;5028.446870844205;5044.461439261061;1254.6361555149088;1270.803025531044;1272.955446559366;1276.7446510697898;1278.3288773394042;785.0696924144793;803.8995125609299;808.878668199763;819.1399031017407;821.7370441458676;4195.349720793282;4258.723182993095;4325.76208308546;4359.280718681445;4410.926864373803;5111.233315002705;5117.718525481134;5120.18077107661;5132.538071573576;5132.79468821243;4384.561543845653;4392.17724644269;4398.296272596369;4401.163778882066;4409.801558929856;2565.6017470478632;2686.395560998799;2689.273896048056;2690.6233127362184;2692.811503194797;4793.5685788279225;4802.423709154854;4808.8797780055775;4810.95189048105;4817.373741413594;5035.169197082514;5229.607779416483;5233.215017747369;5236.423993360727;5253.50091741284;4787.257975013878;4827.565519103227;4841.273808928689;4843.975780121147;4861.51384861511;5091.516305950929;5107.310513080835;5110.565601923729;5116.769745361542;5125.897482050413;4760.500147484464;4998.550130488128;5011.047900898818;5011.724355160502;5014.4484106747495;4813.687110337817;4823.3729615149805;4862.246351815475;4865.464798872192;4873.878153046202;3603.747737658444;3607.729420293541;3621.5473065866768;3632.8728494502566;3645.799481028569;5164.561012313995;5177.8187763428095;5207.646012036822;5209.973950130225;5215.973920130375;4782.952170478251;5019.824306149268;5058.772355243949;5059.46875578059;5094.5160209780015;5045.68812108847;5058.898822023612;5059.291699162194;5059.519345662156;5088.313077734459;4870.659053866196;5001.749912504288;5010.968364139643;5011.248312753116;5023.2214006829;4842.539958703917;4940.333055037668;4993.850184494471;5039.445660977363;5088.532061950025;4910.2880082388565;4920.769807548113;4960.900781984412;4967.453580106113;4968.900621987612 13:01:02 INFO - PROCESS | 12198 | |5;yui.html;598.2193237824637;602.9819105426837;620.8758248350331;697.9844326504933;701.5650296815975;12259.63221103366;13213.339333033346;13552.796708049362;13608.183508989456;13639.318034098305;12951.352432378368;13063.281519516422;13080.149790263626;13081.149725267851;13105.606831795061;626.2578844069792;744.114503740547;766.3983772738402;766.5745511241258;771.2287712287713;778.696308439709;780.4653812138674;781.8084569280534;782;783.2872086401376;812.3095368936416;820.4052062254847;821.5440430561036;822.5023860564362;822.6873787960567;650.847050943028;790.1703211627796;805.4402190477621;813.8901248331458;818.9754307370729;601.5758889982552;602.172013481463;602.5962605054624;602.8764103358801;603.8037637767743;12526.185797923197;12530.185537940004;12531.248125112523;12547.56083537081;12555.121141520005;12079.27524348542;12199.878001219962;12342.382880856012;12407.379631018503;12851.935740321238;10579.576816927314;10752.78494430115;10756;10819.35083894961;11190.608328708457;3986.66113380363;4056.1076563156353;4096.283150448689;4123.690723195772;4246.7027308088445;63730.68134659297;63870.36129638691;64136;67848;67865.66067169682;8486.151384861465;8865.822683546294;9676.854847177297;9815.950920245354;9816.852747208797;17761;17933.37233196832;17951.73072403915;18001.819981800276;18049;6641.070250164981;6657.1012913257055;6666.133402657623;6667.199936007613;6675.732970681215;3704.111013356775;3867.0525721198487;3868.709846761504;3963;3966.702497312713;2758.6965433802266;2853.1583182961076;2853.2866783304175;2869;2871.25347409675;473.1979295094781;487.6269653714911;488.155491000571;489.3149590573155;497.8431793984883;548.3447280499844;556.4741319453159;582.6837085987828;585.1632166002657;590.7961753195141;7430.848218526137;7567.772966811004;7870.212978702199;8080.71717489885;8175.877361839577;427.3248267736968;466.99533004670195;503.92189210672404;505.0000998023933;525.13352967603;3643.85424583019;3795.791231482295;3829.1384438501673;3858.8456461741216;4033.2941735196223;93433.5328323354;102218.48890755499;102726;103266.48366758118;106658.46670766751;50626.49373506291;50639.746801265755;52965;53154.73422632862;95969;43289.783551082044;45632;73496.63251683707;73621.6318918402;83367;8160.8367832641825;8394.538300393537;8444.113368096507;8470.49177049379;8615.569221538773;39991.60008399879;42902.570974291106;42999;43578.34632480452;44650;54283.72858135684;61382.38617613767;61775.69112154411;62536.687316563126;63767;10076.395416275047;10094.091531762177;10318.122959548522;10368.170546356425;10591.89408105909;12333.321667308384;12832.230066195685;12948.8057679133;12983;13514.39185236647;6814.591124532544;10724.678259652223;11645.6506304811;11804;11808.586699465477;11693;11982.520699172284;12183.573574924834;12367.072469564999;12547.43536540876;11360.375179365214;11394.25937314072;11844.76310473803;11853.644390668294;12029.879701202875;9663.565139568596;9914.801703966024;9953.402795832273;10033.297669163088;10056.748581285527;9812.607495700093;10035.849462257926;10077.546510406903;10204.795904081728;10222.1822254218 13:01:02 INFO - PROCESS | 12198 | __end_tp_report 13:01:02 INFO - PROCESS | 12198 | __start_cc_report 13:01:02 INFO - PROCESS | 12198 | _x_x_mozilla_cycle_collect,976 13:01:02 INFO - PROCESS | 12198 | __end_cc_report 13:01:02 INFO - PROCESS | 12198 | __startTimestamp1470686462877__endTimestamp 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | ------- Summary: start ------- 13:01:02 INFO - PROCESS | 12198 | Number of tests: 6 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | [#0] dojo.html Cycles:165 Average:4638.30 Median:4775.76 stddev:493.41 (10.3%) stddev-sans-first:467.95 13:01:02 INFO - PROCESS | 12198 | Values: 2587.2 2592.2 2612.1 2625.4 2632.7 4448.7 4504.1 4616.3 4619.9 4633.8 4559.2 4645.3 4685.3 4722.0 4738.2 4247.7 4272.8 4281.3 4298.0 4354.8 4181.7 4343.2 4376.4 4383.8 4421.2 4170.7 4207.2 4211.6 4326.9 4368.9 4278.1 4318.8 4335.5 4354.5 4389.5 4283.6 4308.1 4310.5 4350.8 4358.3 4388.8 4706.5 4722.0 4746.5 4754.5 4887.1 4910.3 4928.6 5017.1 5018.5 5036.0 5039.3 5045.3 5051.1 5052.1 4641.7 4687.6 4693.3 4696.0 4698.6 4959.3 5098.6 5131.9 5133.0 5173.6 4970.8 5015.4 5020.5 5021.0 5025.7 5045.2 5049.9 5081.1 5094.3 5103.5 4756.2 4986.9 5003.4 5067.5 5069.1 5010.1 5027.1 5031.7 5035.4 5065.3 4269.8 4308.0 4309.6 4339.1 4352.7 3634.2 3647.3 3697.7 3712.7 3737.9 4314.9 4318.3 4345.3 4350.3 4363.0 5031.1 5036.1 5041.7 5042.9 5076.6 4181.7 4235.9 4270.5 4290.8 4344.8 4529.0 4533.7 4547.9 4588.4 4609.0 4757.4 4772.3 4774.3 4777.5 4824.9 4845.0 4994.6 5060.0 5081.5 5092.4 4737.9 4775.8 4777.7 4801.1 4820.8 4976.6 4982.9 4983.3 4993.7 5033.3 4771.4 4926.4 5040.5 5049.2 5102.0 4811.5 4853.7 4875.4 4900.7 4916.0 4860.5 4872.6 4874.1 4874.5 4923.7 4634.5 4806.0 4812.7 4862.6 4864.8 4893.4 4931.1 4960.4 4997.3 5006.7 4846.2 4853.6 4854.0 4856.8 4909.3 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | [#1] ext.html Cycles:180 Average:46745.64 Median:20101.90 stddev:84624.99 (421.0%) stddev-sans-first:84791.37 13:01:02 INFO - PROCESS | 12198 | Values: 571.0 578.7 587.5 593.7 601.6 29026.9 32070.8 32143.2 39715.6 40736.6 41125.2 41568.2 41617.6 41725.8 41763.8 7645.8 7769.9 7778.5 7779.6 7783.8 7672.6 7742.6 7755.3 7756.2 7759.7 7760.9 7794.7 7811.6 7813.6 7817.6 7718.1 7745.1 7758.6 7759.6 7760.1 7688.3 7739.1 7745.9 7758.1 7763.1 39098.2 39441.6 39488.2 39529.4 39559.4 3070.9 3202.2 3211.4 3270.1 3628.3 28922.6 28997.9 29241.5 29420.4 30711.0 3248.5 3260.7 3272.2 3284.2 3354.7 249819.0 250453.0 250745.0 251142.7 251539.0 52446.6 52618.0 52752.0 52766.7 52783.0 32671.7 33891.2 33921.3 35810.8 35862.3 12941.8 12971.4 12984.5 13004.2 13022.1 9958.7 9974.9 10019.5 10032.2 10055.3 18250.5 18250.9 18302.1 18365.6 18365.7 6662.9 6678.7 6700.6 6728.6 6804.4 844.3 890.2 971.0 1002.1 1005.5 26558.6 27071.6 27280.6 27677.6 27807.6 851.4 949.5 969.9 1010.1 1042.3 13937.3 14514.6 14966.5 15054.7 15108.9 377694.0 379340.0 380187.0 381486.0 381487.0 47968.8 48296.0 48325.3 48341.5 48388.4 1088.9 1158.8 1185.1 1207.8 1213.6 28293.0 29105.0 29358.0 29614.7 30227.5 42725.1 43229.8 43236.0 43240.1 43277.4 299749.0 301681.0 302427.0 303123.0 388009.0 35149.6 38563.0 38589.4 38769.6 38859.0 41781.4 41908.6 41952.0 42041.6 42126.0 33514.2 33672.8 33714.5 33723.8 33868.3 33000.7 33280.8 33675.5 33725.0 34142.5 35984.3 36575.5 36687.6 36961.0 37240.3 29821.6 30736.4 31910.8 32001.5 32188.0 25432.2 25587.0 25875.5 25922.7 26239.1 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | [#2] jquery.html Cycles:180 Average:23845.94 Median:5069.02 stddev:63531.23 (1253.3%) stddev-sans-first:63684.91 13:01:02 INFO - PROCESS | 12198 | Values: 326.5 350.1 355.2 355.4 372.7 12772.6 13291.9 13812.9 16197.5 16282.2 16672.7 16673.9 17367.7 17527.1 17534.4 4995.7 5042.4 5206.1 5239.9 5311.2 3412.8 5195.4 5205.2 5214.7 5244.9 3564.0 4756.2 6020.8 6082.4 6084.3 5708.8 6051.6 6055.4 6062.5 6062.6 5061.9 5076.1 5078.1 5078.8 5082.3 11376.3 11386.0 11432.7 11447.1 11544.8 1771.9 1893.1 1901.5 1922.7 1939.1 8411.7 8468.7 8884.6 9044.7 9244.0 1639.6 1696.2 1696.6 1726.0 1811.6 59821.0 68987.7 70482.3 70613.0 71963.3 9257.6 9344.7 9640.4 9698.1 9756.5 12856.0 12904.0 12933.3 12934.2 12969.9 6419.4 6633.7 6634.1 6691.8 6735.7 6084.1 6101.5 6227.1 6255.3 6257.8 3988.8 4091.1 4105.4 4186.1 4210.9 1645.9 1654.3 1685.2 1716.1 1746.3 765.8 847.5 908.2 909.2 965.1 16300.8 16447.4 17108.9 17159.2 17318.7 817.8 832.7 846.9 848.8 862.1 9174.4 9427.3 9489.6 9551.9 9755.5 380304.0 381385.0 383676.0 385547.0 388449.0 73856.0 74069.6 75127.0 75466.0 77931.0 837.2 861.4 877.9 887.6 891.9 15650.6 15791.7 16165.4 16200.2 16321.5 40426.2 40692.4 40922.8 41136.0 41395.4 54533.5 54698.0 55404.4 55769.4 55789.4 4914.6 6941.9 7203.7 7574.5 7681.9 8047.6 11575.8 11698.2 11827.2 12242.0 9720.3 9756.8 10452.7 10938.9 11057.4 9683.7 9870.9 10017.2 10049.8 10095.0 10196.4 10337.8 10497.5 10828.6 11213.0 7082.4 7115.6 7157.0 7223.1 7458.2 9732.5 10405.1 10460.7 10752.1 10799.2 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | [#3] mootools.html Cycles:180 Average:5022.09 Median:5289.51 stddev:2787.31 (52.7%) stddev-sans-first:2780.82 13:01:02 INFO - PROCESS | 12198 | Values: 1264.8 1367.3 1414.6 1481.4 1681.0 6236.3 7373.0 7615.0 7662.1 7849.1 7675.5 7732.2 7737.5 7751.9 7753.5 2175.5 2201.5 2202.9 2203.4 2206.2 2112.5 2163.0 2166.6 2167.2 2169.9 2151.3 2159.3 2164.7 2165.9 2198.4 2129.5 2132.7 2135.0 2136.5 2136.7 2069.8 2127.7 2132.5 2134.6 2135.6 7519.3 7625.5 7634.0 7638.2 7704.5 4406.9 4556.1 4608.1 4616.1 4618.2 2734.0 2813.2 2876.2 2881.2 2881.6 902.5 909.9 916.0 920.6 930.3 10058.1 10207.3 10273.6 10365.4 10373.1 3839.3 4006.4 4155.0 4157.8 4161.3 8851.4 8852.8 8855.2 8861.0 8861.2 4538.2 4540.3 4580.1 4590.5 4595.5 3365.7 3948.5 3988.1 3996.4 4137.0 3571.7 3644.9 3731.6 3742.8 3751.8 1110.0 1152.8 1162.6 1165.1 1165.8 747.3 797.5 805.0 817.7 841.3 5001.8 5136.4 5174.5 5216.0 5312.4 835.9 849.6 852.3 879.8 884.4 3340.2 3625.8 3656.3 3666.9 3743.3 8779.4 8920.0 9425.2 9427.7 9428.1 9089.4 9375.3 9390.2 9396.7 9410.7 6777.5 6811.4 6987.8 7024.8 7029.0 5220.6 5266.7 5484.5 5580.6 5586.8 8756.3 8778.2 8805.6 8884.6 8891.9 8647.7 8761.1 8848.7 8944.9 9010.0 5388.8 5722.8 6546.1 6662.0 6683.4 7231.9 7482.6 7485.0 7485.3 7487.2 6615.5 6641.5 6671.3 6791.9 6798.6 6570.6 6579.4 6617.2 6620.8 6622.5 6176.4 6223.8 6249.0 6255.5 6264.5 4332.8 4353.3 4422.1 4550.5 4590.2 4392.7 4442.6 4473.9 4544.8 4549.4 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | [#4] prototype.html Cycles:180 Average:4138.41 Median:4765.46 stddev:1213.83 (25.5%) stddev-sans-first:1182.29 13:01:02 INFO - PROCESS | 12198 | Values: 286.0 289.3 294.5 298.3 299.1 4770.4 4796.7 4808.4 4810.5 4810.5 4714.5 4738.2 4744.7 4747.7 4754.3 3546.2 3652.4 3670.4 3715.1 3740.5 3724.6 3732.5 3734.9 3739.7 3743.7 3686.6 3709.9 3713.8 3724.5 3725.9 3538.6 3574.4 3685.3 3691.2 3691.9 3191.7 3216.6 3238.7 3245.5 3246.8 4481.8 4561.8 4565.9 4583.2 4604.4 3996.2 4202.7 4211.9 4212.3 4241.1 4951.6 4978.9 4983.3 5002.5 5002.7 3532.9 3553.5 3576.9 3578.2 3590.7 5081.2 5274.9 5296.6 5297.9 5305.4 3615.4 3623.8 3626.6 3636.8 3645.5 3684.9 3687.9 3688.6 3697.8 3709.9 4193.2 4195.2 4207.2 4209.0 4220.7 4887.4 4985.7 5010.0 5028.4 5044.5 1254.6 1270.8 1273.0 1276.7 1278.3 785.1 803.9 808.9 819.1 821.7 4195.3 4258.7 4325.8 4359.3 4410.9 5111.2 5117.7 5120.2 5132.5 5132.8 4384.6 4392.2 4398.3 4401.2 4409.8 2565.6 2686.4 2689.3 2690.6 2692.8 4793.6 4802.4 4808.9 4811.0 4817.4 5035.2 5229.6 5233.2 5236.4 5253.5 4787.3 4827.6 4841.3 4844.0 4861.5 5091.5 5107.3 5110.6 5116.8 5125.9 4760.5 4998.6 5011.0 5011.7 5014.4 4813.7 4823.4 4862.2 4865.5 4873.9 3603.7 3607.7 3621.5 3632.9 3645.8 5164.6 5177.8 5207.6 5210.0 5216.0 4783.0 5019.8 5058.8 5059.5 5094.5 5045.7 5058.9 5059.3 5059.5 5088.3 4870.7 5001.7 5011.0 5011.2 5023.2 4842.5 4940.3 4993.9 5039.4 5088.5 4910.3 4920.8 4960.9 4967.5 4968.9 13:01:02 INFO - PROCESS | 12198 | 13:01:02 INFO - PROCESS | 12198 | [#5] yui.html Cycles:180 Average:16824.11 Median:45141.00 stddev:24002.75 (53.2%) stddev-sans-first:24039.17 13:01:02 INFO - PROCESS | 12198 | Values: 598.2 603.0 620.9 698.0 701.6 12259.6 13213.3 13552.8 13608.2 13639.3 12951.4 13063.3 13080.1 13081.1 13105.6 626.3 744.1 766.4 766.6 771.2 778.7 780.5 781.8 782.0 783.3 812.3 820.4 821.5 822.5 822.7 650.8 790.2 805.4 813.9 819.0 601.6 602.2 602.6 602.9 603.8 12526.2 12530.2 12531.2 12547.6 12555.1 12079.3 12199.9 12342.4 12407.4 12851.9 10579.6 10752.8 10756.0 10819.4 11190.6 3986.7 4056.1 4096.3 4123.7 4246.7 63730.7 63870.4 64136.0 67848.0 67865.7 8486.2 8865.8 9676.9 9816.0 9816.9 17761.0 17933.4 17951.7 18001.8 18049.0 6641.1 6657.1 6666.1 6667.2 6675.7 3704.1 3867.1 3868.7 3963.0 3966.7 2758.7 2853.2 2853.3 2869.0 2871.3 473.2 487.6 488.2 489.3 497.8 548.3 556.5 582.7 585.2 590.8 7430.8 7567.8 7870.2 8080.7 8175.9 427.3 467.0 503.9 505.0 525.1 3643.9 3795.8 3829.1 3858.8 4033.3 93433.5 102218.5 102726.0 103266.5 106658.5 50626.5 50639.7 52965.0 53154.7 95969.0 43289.8 45632.0 73496.6 73621.6 83367.0 8160.8 8394.5 8444.1 8470.5 8615.6 39991.6 42902.6 42999.0 43578.3 44650.0 54283.7 61382.4 61775.7 62536.7 63767.0 10076.4 10094.1 10318.1 10368.2 10591.9 12333.3 12832.2 12948.8 12983.0 13514.4 6814.6 10724.7 11645.7 11804.0 11808.6 11693.0 11982.5 12183.6 12367.1 12547.4 11360.4 11394.3 11844.8 11853.6 12029.9 9663.6 9914.8 9953.4 10033.3 10056.7 9812.6 10035.8 10077.5 10204.8 10222.2 13:01:02 INFO - PROCESS | 12198 | -------- Summary: end -------- 13:01:02 INFO - PROCESS | 12198 | 13:01:03 INFO - TEST-INFO | 12198: exit 0 13:01:03 INFO - TEST-OK | dromaeo_css | took 1119225ms 13:01:03 INFO - TEST-START | kraken 13:01:03 INFO - operating with platform_type : linux_ 13:01:03 INFO - Initialising browser for kraken test... 13:01:03 INFO - TEST-INFO | started process 12391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyoZYRz/profile http://localhost:47804/getInfo.html) 13:01:07 INFO - PROCESS | 12391 | __metrics Screen width/height:1600/1200 13:01:07 INFO - PROCESS | 12391 | colorDepth:24 13:01:07 INFO - PROCESS | 12391 | Browser inner width/height: 1024/697 13:01:07 INFO - PROCESS | 12391 | __metrics 13:01:08 INFO - PROCESS | 12391 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:01:08 INFO - PROCESS | 12391 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:01:09 INFO - TEST-INFO | 12391: exit 0 13:01:09 INFO - Browser initialized. 13:01:09 INFO - Running cycle 1/1 for kraken test... 13:01:09 INFO - TEST-INFO | started process 12472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyoZYRz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:21 INFO - PROCESS | 12472 | RSS: Main: 158220288 13:01:21 INFO - PROCESS | 12472 | 13:01:24 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47804/tests/kraken/driver.html?testName=audio-beat-detection) 13:01:25 INFO - PROCESS | 12472 | RSS: Main: 214179840 13:01:25 INFO - PROCESS | 12472 | 13:01:28 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47804/tests/kraken/driver.html?testName=audio-dft) 13:01:28 INFO - PROCESS | 12472 | RSS: Main: 192368640 13:01:28 INFO - PROCESS | 12472 | 13:01:31 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47804/tests/kraken/driver.html?testName=audio-fft) 13:01:32 INFO - PROCESS | 12472 | RSS: Main: 271974400 13:01:32 INFO - PROCESS | 12472 | 13:01:34 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47804/tests/kraken/driver.html?testName=audio-oscillator) 13:01:35 INFO - PROCESS | 12472 | RSS: Main: 180289536 13:01:35 INFO - PROCESS | 12472 | 13:01:37 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47804/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:01:38 INFO - PROCESS | 12472 | RSS: Main: 185458688 13:01:38 INFO - PROCESS | 12472 | 13:01:41 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47804/tests/kraken/driver.html?testName=imaging-darkroom) 13:01:41 INFO - PROCESS | 12472 | RSS: Main: 221741056 13:01:41 INFO - PROCESS | 12472 | 13:01:45 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47804/tests/kraken/driver.html?testName=imaging-desaturate) 13:01:46 INFO - PROCESS | 12472 | RSS: Main: 215384064 13:01:46 INFO - PROCESS | 12472 | 13:01:48 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47804/tests/kraken/driver.html?testName=json-parse-financial) 13:01:49 INFO - PROCESS | 12472 | RSS: Main: 218595328 13:01:49 INFO - PROCESS | 12472 | 13:01:51 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47804/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:01:51 INFO - PROCESS | 12472 | RSS: Main: 184115200 13:01:51 INFO - PROCESS | 12472 | 13:01:53 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:01:54 INFO - PROCESS | 12472 | RSS: Main: 191082496 13:01:54 INFO - PROCESS | 12472 | 13:01:56 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:01:57 INFO - PROCESS | 12472 | RSS: Main: 195100672 13:01:57 INFO - PROCESS | 12472 | 13:01:59 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:02:00 INFO - PROCESS | 12472 | RSS: Main: 188932096 13:02:00 INFO - PROCESS | 12472 | 13:02:03 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:02:04 INFO - PROCESS | 12472 | RSS: Main: 192208896 13:02:04 INFO - PROCESS | 12472 | 13:02:05 INFO - PROCESS | 12472 | Cycle 1(1): loaded http://localhost:47804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47804/tests/kraken/driver.html?testName=ai-astar) 13:02:06 INFO - PROCESS | 12472 | RSS: Main: 242257920 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | __start_tp_report 13:02:06 INFO - PROCESS | 12472 | _x_x_mozilla_page_load 13:02:06 INFO - PROCESS | 12472 | _x_x_mozilla_page_load_details 13:02:06 INFO - PROCESS | 12472 | |i|pagename|runs| 13:02:06 INFO - PROCESS | 12472 | |0;ai-astar;103;114;114;113;113;115;114;115;113;116 13:02:06 INFO - PROCESS | 12472 | |1;audio-beat-detection;153;124;122;185;123;125;144;127;160;121 13:02:06 INFO - PROCESS | 12472 | |2;audio-dft;162;162;162;161;160;161;160;161;164;161 13:02:06 INFO - PROCESS | 12472 | |3;audio-fft;76;77;75;102;75;75;75;74;105;76 13:02:06 INFO - PROCESS | 12472 | |4;audio-oscillator;85;86;128;85;86;86;121;86;85;129 13:02:06 INFO - PROCESS | 12472 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 13:02:06 INFO - PROCESS | 12472 | |6;imaging-darkroom;145;146;147;146;146;146;147;148;146;146 13:02:06 INFO - PROCESS | 12472 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;96;95 13:02:06 INFO - PROCESS | 12472 | |8;json-parse-financial;63;62;63;62;62;63;63;64;62;63 13:02:06 INFO - PROCESS | 12472 | |9;json-stringify-tinderbox;65;65;65;64;64;65;64;65;64;64 13:02:06 INFO - PROCESS | 12472 | |10;stanford-crypto-aes;80;78;79;79;79;79;79;83;79;79 13:02:06 INFO - PROCESS | 12472 | |11;stanford-crypto-ccm;139;138;137;131;130;129;131;128;148;138 13:02:06 INFO - PROCESS | 12472 | |12;stanford-crypto-pbkdf2;166;165;166;166;164;170;165;166;165;163 13:02:06 INFO - PROCESS | 12472 | |13;stanford-crypto-sha256-iterative;67;68;67;67;69;67;67;67;65;67 13:02:06 INFO - PROCESS | 12472 | __end_tp_report 13:02:06 INFO - PROCESS | 12472 | __start_cc_report 13:02:06 INFO - PROCESS | 12472 | _x_x_mozilla_cycle_collect,1925 13:02:06 INFO - PROCESS | 12472 | __end_cc_report 13:02:06 INFO - PROCESS | 12472 | __startTimestamp1470686526010__endTimestamp 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | ------- Summary: start ------- 13:02:06 INFO - PROCESS | 12472 | Number of tests: 14 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.65 (3.2%) stddev-sans-first:1.05 13:02:06 INFO - PROCESS | 12472 | Values: 103.0 114.0 114.0 113.0 113.0 115.0 114.0 115.0 113.0 116.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:135.50 stddev:21.62 (16.0%) stddev-sans-first:22.28 13:02:06 INFO - PROCESS | 12472 | Values: 153.0 124.0 122.0 185.0 123.0 125.0 144.0 127.0 160.0 121.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 13:02:06 INFO - PROCESS | 12472 | Values: 162.0 162.0 162.0 161.0 160.0 161.0 160.0 161.0 164.0 161.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:11.91 (15.9%) stddev-sans-first:12.49 13:02:06 INFO - PROCESS | 12472 | Values: 76.0 77.0 75.0 102.0 75.0 75.0 75.0 74.0 105.0 76.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.50 stddev:19.64 (23.0%) stddev-sans-first:20.29 13:02:06 INFO - PROCESS | 12472 | Values: 85.0 86.0 128.0 85.0 86.0 86.0 121.0 86.0 85.0 129.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:02:06 INFO - PROCESS | 12472 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 13:02:06 INFO - PROCESS | 12472 | Values: 145.0 146.0 147.0 146.0 146.0 146.0 147.0 148.0 146.0 146.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:02:06 INFO - PROCESS | 12472 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 13:02:06 INFO - PROCESS | 12472 | Values: 63.0 62.0 63.0 62.0 62.0 63.0 63.0 64.0 62.0 63.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:02:06 INFO - PROCESS | 12472 | Values: 65.0 65.0 65.0 64.0 64.0 65.0 64.0 65.0 64.0 64.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.35 (1.7%) stddev-sans-first:1.41 13:02:06 INFO - PROCESS | 12472 | Values: 80.0 78.0 79.0 79.0 79.0 79.0 79.0 83.0 79.0 79.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:137.50 stddev:6.23 (4.5%) stddev-sans-first:6.42 13:02:06 INFO - PROCESS | 12472 | Values: 139.0 138.0 137.0 131.0 130.0 129.0 131.0 128.0 148.0 138.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 13:02:06 INFO - PROCESS | 12472 | Values: 166.0 165.0 166.0 166.0 164.0 170.0 165.0 166.0 165.0 163.0 13:02:06 INFO - PROCESS | 12472 | 13:02:06 INFO - PROCESS | 12472 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 13:02:06 INFO - PROCESS | 12472 | Values: 67.0 68.0 67.0 67.0 69.0 67.0 67.0 67.0 65.0 67.0 13:02:06 INFO - PROCESS | 12472 | -------- Summary: end -------- 13:02:06 INFO - PROCESS | 12472 | 13:02:07 INFO - TEST-INFO | 12472: exit 0 13:02:07 INFO - TEST-OK | kraken | took 63421ms 13:02:07 INFO - SUITE-END | took 1182s 13:02:07 INFO - Completed test suite (00:19:42) 13:02:07 INFO - javascript benchmark 13:02:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.236765154282, 2592.22233330001, 2612.0988259050628, 2625.396158883457, 2632.670916135483, 4448.666350023745, 4504.099180163972, 4616.307553866922, 4619.930701039487, 4633.791479383423, 4559.202139625569, 4645.279981602848, 4685.2737825637, 4721.952780472194, 4738.194506933821, 4247.723897946639, 4272.764997925113, 4281.272183728765, 4298.032942587924, 4354.804033818486, 4181.665466762652, 4343.153085148398, 4376.363256078011, 4383.802728877208, 4421.226285400042, 4170.749755014709, 4207.200631879933, 4211.620954114113, 4326.891827704301, 4368.89077773055, 4278.080212754242, 4318.848840290575, 4335.458067741532, 4354.455693038371, 4389.495208051083, 4283.614474697261, 4308.052228509723, 4310.547392523771, 4350.8042138103865, 4358.259095953696, 4388.802503887333, 4706.482286948433, 4722.031983443386, 4746.501617330199, 4754.477007529169, 4887.0714564232685, 4910.288008238786, 4928.556429921288, 5017.096922553938, 5018.548330650259, 5036.017976494585, 5039.294498770175, 5045.268436076785, 5051.065552872694, 5052.065367906949, 4641.651876109306, 4687.62499000086, 4693.342931989524, 4695.976520117446, 4698.647601429906, 4959.2809042688605, 5098.566621837185, 5131.923021154686, 5132.9743351283005, 5173.5602473789395, 4970.776315065831, 5015.448300686921, 5020.49795020495, 5021.0, 5025.748712564357, 5045.217991211368, 5049.873753156127, 5081.136206844845, 5094.286799848024, 5103.515166059218, 4756.167670657621, 4986.850394488099, 5003.449620541737, 5067.5185857343495, 5069.112905241568, 5010.073136469765, 5027.095122877917, 5031.74841257943, 5035.446100928895, 5065.316182315414, 4269.829206831754, 4308.030693094029, 4309.633681137138, 4339.1104823511105, 4352.73883566987, 3634.182308980511, 3647.252313275772, 3697.6672099511175, 3712.7401081924545, 3737.9065523362133, 4314.913701726011, 4318.330658747899, 4345.304751239786, 4350.260455722535, 4362.956370436318, 5031.144705400091, 5036.11867923112, 5041.722705251246, 5042.899142017212, 5076.6192535559985, 4181.707280490397, 4235.8729238122905, 4270.530241673413, 4290.82836686529, 4344.804483798237, 4528.954710452919, 4533.659975501784, 4547.886302842456, 4588.357629931812, 4608.953910460852, 4757.371083916969, 4772.308015337826, 4774.283857421415, 4777.522247775195, 4824.855254342376, 4844.975775121102, 4994.575461085703, 5060.038592667382, 5081.4664460232625, 5092.388913330424, 4737.857864264078, 4775.761211939459, 4777.689450185866, 4801.087793319258, 4820.807167713252, 4976.552110310089, 4982.925256121089, 4983.25251212321, 4993.650444468853, 5033.320501732219, 4771.427428708577, 4926.433460152129, 5040.521150490697, 5049.217371307306, 5101.974490127525, 4811.542903424169, 4853.6602437829015, 4875.439324477588, 4900.730459824744, 4916.016796640614, 4860.465348811557, 4872.585830204331, 4874.098291816025, 4874.488178741181, 4923.65534412602, 4634.513376095596, 4805.951940480551, 4812.735299558558, 4862.610991120772, 4864.805407783649, 4893.363862697969, 4931.0630980113665, 4960.404751429852, 4997.325361076353, 5006.7246301452315, 4846.151923413318, 4853.635977301646, 4853.975730121327, 4856.830010949741, 4909.288153217692], "value": 4606.465326492325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9543236541076, 578.7164289498147, 587.5270407322107, 593.7120496559165, 601.563866197007, 29026.85486572567, 32070.839645801796, 32143.19642008951, 39715.60284397155, 40736.59263407373, 41125.17749645013, 41568.16863662725, 41617.583824161746, 41725.7913710431, 41763.79118104405, 7645.847083058336, 7769.922300777004, 7778.49439786412, 7779.572123533203, 7783.766487005399, 7672.578008209574, 7742.612869356538, 7755.302022817945, 7756.224377562255, 7759.6508157132785, 7760.883586746203, 7794.688212471494, 7811.609419529029, 7813.570253636048, 7817.648205830723, 7718.112417072024, 7745.1093124290865, 7758.612069396536, 7759.612019399064, 7760.107587627383, 7688.34649054831, 7739.148693643695, 7745.883811742829, 7758.14660387357, 7763.146053934062, 39098.21803563941, 39441.605583944365, 39488.21023579512, 39529.40705889414, 39559.40660890089, 3070.9385812283854, 3202.1834432219866, 3211.3898359311656, 3270.133414645121, 3628.3468975584383, 28922.566161507384, 28997.855010724812, 29241.491021077392, 29420.411591768257, 30711.0, 3248.5127230915314, 3260.7228385587255, 3272.181954511372, 3284.1953721338186, 3354.714849237818, 249819.0, 250453.0, 250745.0, 251142.74428627922, 251539.0, 52446.590971586724, 52618.0, 52752.0, 52766.73616631892, 52783.0, 32671.673283267337, 33891.15272118217, 33921.32157356839, 35810.8209458951, 35862.282754344764, 12941.805872911913, 12971.41628626714, 12984.480620775252, 13004.154729942524, 13022.088453808332, 9958.701238962843, 9974.850377244347, 10019.549120289605, 10032.247581431422, 10055.346402483816, 18250.45248642516, 18250.90874545619, 18302.08489575516, 18365.632687346177, 18365.7245141323, 6662.900056499157, 6678.699458524378, 6700.597964122168, 6728.635682158921, 6804.353586409283, 844.2950136635977, 890.2166093837382, 971.0338213477635, 1002.1331548210745, 1005.4821766790109, 26558.6016209757, 27071.593926091125, 27280.590791138147, 27677.584836227474, 27807.58288625672, 851.3870013590205, 949.4635530925005, 969.9418034917786, 1010.0505524806658, 1042.3485321673954, 13937.303134843218, 14514.570563546973, 14966.476173333882, 15054.654354878961, 15108.924455377653, 377694.0, 379340.0, 380187.0, 381486.0, 381487.0, 47968.760156198994, 48296.0, 48325.275120873215, 48341.5165848337, 48388.403101705284, 1088.8911108889047, 1158.79141754485, 1185.1348515583672, 1207.7886369885412, 1213.6419756171952, 28293.0, 29105.0, 29358.0, 29614.703852961196, 30227.546586801654, 42725.14549708926, 43229.783851080545, 43236.0, 43240.13519729525, 43277.35083973806, 299749.0, 301681.0, 302427.0, 303123.0, 388009.0, 35149.64850351464, 38563.0, 38589.42115868208, 38769.6123038766, 38859.0, 41781.37327940023, 41908.58091419047, 41952.0, 42041.57958420377, 42126.0, 33514.16214594557, 33672.831635842645, 33714.494282586274, 33723.83138084294, 33868.32263354769, 33000.66999330072, 33280.833595831864, 33675.494867577494, 33725.0, 34142.487862682574, 35984.28031439409, 36575.45136823003, 36687.63312366842, 36961.0, 37240.25519489649, 29821.552676709434, 30736.385272294876, 31910.84044579762, 32001.519977200827, 32188.0, 25432.237032889043, 25586.976520938955, 25875.45040655243, 25922.74077259203, 26239.081632142785], "value": 17294.00283322198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.47111679079893, 350.1037344398339, 355.236242079529, 355.40824527162266, 372.69066674660036, 12772.616821495358, 13291.93354033231, 13812.93093534532, 16197.514074577752, 16282.185890705447, 16672.66654666906, 16673.91663041686, 17367.652646947052, 17527.12364381782, 17534.386296479624, 4995.725235112068, 5042.369703787018, 5206.062908676437, 5239.921401178985, 5311.203319502067, 3412.778169418992, 5195.350581177353, 5205.245239440279, 5214.713190774506, 5244.895102097956, 3563.964360356389, 4756.215224487955, 6020.789272375468, 6082.391760823904, 6084.330723620398, 5708.77164913403, 6051.576389652726, 6055.394460553954, 6062.484688801457, 6062.605930614518, 5061.949380506221, 5076.086304465195, 5078.085944529983, 5078.847634570931, 5082.3138876251605, 11376.317420954769, 11386.0, 11432.71418214543, 11447.141464390204, 11544.76910461786, 1771.9153396253482, 1893.1386219270198, 1901.5246188452886, 1922.7404300419405, 1939.146775418811, 8411.705590304371, 8468.745937621881, 8884.555772211364, 9044.683436079771, 9243.953780231055, 1639.5655151384892, 1696.2282161616436, 1696.567375319298, 1725.965480690379, 1811.5561687386544, 59821.0, 68987.65506172487, 70482.29517704809, 70613.0, 71963.28036719619, 9257.583408746623, 9344.719658410258, 9640.373375730554, 9698.078682525149, 9756.512174391251, 12856.0, 12904.0, 12933.288669123289, 12934.159279646792, 12969.870301297055, 6419.358064193543, 6633.701483433257, 6634.104395906587, 6691.76578819739, 6735.663216839139, 6084.11780291864, 6101.481374083164, 6227.1282020516255, 6255.280642726054, 6257.78097766576, 3988.780617066031, 4091.1204091120553, 4105.4252404663375, 4186.1418409226035, 4210.915781684349, 1645.9012459252244, 1654.3051918194387, 1685.2079522624347, 1716.1333526569003, 1746.2840235503384, 765.8468306338643, 847.4999750147442, 908.2143945487106, 909.1726528858707, 965.0735294117585, 16300.836991629933, 16447.424340148038, 17108.914455427894, 17159.227834747468, 17318.740218896728, 817.7710241132493, 832.6586099699094, 846.9026062002825, 848.8344772769251, 862.0991064337782, 9174.403663761834, 9427.292953028413, 9489.620415183454, 9551.949285578581, 9755.463449510204, 380304.0, 381385.0, 383676.0, 385547.0, 388449.0, 73856.0, 74069.6296518514, 75127.0, 75466.0, 77931.0, 837.1670188162817, 861.3970220845433, 877.8727084572702, 887.6405055952349, 891.9375643704878, 15650.608734781721, 15791.68416631684, 16165.4342098026, 16200.189990500663, 16321.510354689379, 40426.1914761709, 40692.389614156404, 40922.79538602288, 41136.0, 41395.379069314586, 54533.45466545284, 54698.0, 55404.44595553993, 55769.44230557805, 55789.442105578426, 4914.5822605078965, 6941.924001779732, 7203.703333399829, 7574.545527268381, 7681.9231807683445, 8047.597620118853, 11575.826362604399, 11698.181127321346, 11827.17209795306, 12242.0, 9720.270979676694, 9756.756081097745, 10452.68641940743, 10938.945305273422, 11057.447127643747, 9683.709488715349, 9870.901290987285, 10017.198624110199, 10049.849252261076, 10095.0, 10196.4391958443, 10337.84493232587, 10497.52761125736, 10828.566857325619, 11213.046891014355, 7082.3979961703835, 7115.6086415247655, 7157.0, 7223.133224012942, 7458.216887226763, 9732.464714440774, 10405.115565176742, 10460.68617941463, 10752.086072683596, 10799.244052916534], "value": 7879.151628042806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.8166015927698, 1367.2821768571498, 1414.6109819799558, 1481.3926290221004, 1681.025005496812, 6236.314005459396, 7373.0, 7615.048118985127, 7662.080550333953, 7849.136594974562, 7675.539467631946, 7732.188120247363, 7737.535747855119, 7751.922480775204, 7753.496022758517, 2175.5431359414542, 2201.5376770878056, 2202.933911982635, 2203.4050806282294, 2206.1947389202987, 2112.4718820294925, 2163.0374483354835, 2166.5883482138343, 2167.1873047607146, 2169.902354394048, 2151.3330867431146, 2159.3090211132444, 2164.718586583742, 2165.9350219493363, 2198.373463562885, 2129.4995676016124, 2132.69075983983, 2134.967975480369, 2136.4872430616697, 2136.7329083864515, 2069.7826728193622, 2127.6702111172795, 2132.4562236629718, 2134.6050980568643, 2135.562209746998, 7519.285667861544, 7625.542467451915, 7633.961830190813, 7638.1979892111085, 7704.46068775186, 4406.911861762779, 4556.088782243564, 4608.101420223058, 4616.146012987608, 4618.1687296286655, 2734.0, 2813.212300555848, 2876.194665493644, 2881.1644623059287, 2881.6109825173544, 902.4585248850638, 909.8544232922767, 916.0473107967706, 920.6087412849579, 930.2557953637063, 10058.094771470604, 10207.336523125972, 10273.640422585173, 10365.378077315385, 10373.0664240218, 3839.3281175794123, 4006.358982562776, 4155.023569461174, 4157.833686652561, 4161.292580261303, 8851.424657397249, 8852.822943541094, 8855.247303979106, 8860.955695221483, 8861.24679402245, 4538.228501154812, 4540.341650460665, 4580.083983203373, 4590.495045545054, 4595.471520775153, 3365.697087262158, 3948.506436695413, 3988.142549351903, 3996.360582306817, 4137.027798467358, 3571.714262858965, 3644.872429465009, 3731.589525152231, 3742.8315725792404, 3751.7748935063983, 1109.972250693723, 1152.7579208366337, 1162.633770362333, 1165.143619439711, 1165.81929800881, 747.3236720767713, 797.5015615240475, 805.04602046575, 817.7138001699358, 841.3017195727532, 5001.799928002912, 5136.43499215086, 5174.456682048406, 5216.0, 5312.362516497968, 835.8829763833069, 849.5837039850552, 852.2840813716508, 879.824035192964, 884.4428010353436, 3340.1816554943707, 3625.818709064536, 3656.305301992613, 3666.8899933002053, 3743.2513497300647, 8779.385443018928, 8920.0, 9425.151736343762, 9427.670031548863, 9428.057194280655, 9089.409188402733, 9375.296852736072, 9390.154886060287, 9396.67111651089, 9410.717678469657, 6777.49168812341, 6811.352921472452, 6987.825304367329, 7024.824379390556, 7029.0, 5220.582353411642, 5266.657667251617, 5484.478974497416, 5580.609357345109, 5586.832395028156, 8756.343274254328, 8778.209961103532, 8805.559722013746, 8884.555772211494, 8891.866622000805, 8647.654093836176, 8761.080086590817, 8848.734537963872, 8944.910550894669, 9010.0, 5388.811391601275, 5722.799702010409, 6546.083548303146, 6661.966690166518, 6683.365080317362, 7231.891521627285, 7482.551046937201, 7484.962575187089, 7485.288897554724, 7487.176410594939, 6615.536912416084, 6641.468682505485, 6671.299513551007, 6791.932080679328, 6798.626075565693, 6570.638614876037, 6579.407853293226, 6617.172853393326, 6620.768273110418, 6622.503312251697, 6176.4441200292185, 6223.813285601439, 6249.031400132987, 6255.53083518747, 6264.498840092872, 4332.761698106634, 4353.259945809284, 4422.115576884572, 4550.522195169592, 4590.196715574828, 4392.692511524163, 4442.622377097983, 4473.888152796206, 4544.7500387479, 4549.385832912514], "value": 4057.3261309810387, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.9928501787455, 289.2796935630281, 294.49641113695577, 298.3495978766289, 299.07883718148105, 4770.427548694157, 4796.664233503656, 4808.422989241287, 4810.470848206694, 4810.494898035704, 4714.457837348706, 4738.2418812989845, 4744.69159504632, 4747.715137091777, 4754.286856971456, 3546.2375589248372, 3652.41561350184, 3670.4310831820976, 3715.071232191952, 3740.5137332146783, 3724.646158614927, 3732.4961130247475, 3734.9066273343246, 3739.663430291273, 3743.737938344317, 3686.6313368663054, 3709.851605935773, 3713.758605690635, 3724.5158129443134, 3725.882235329404, 3538.6461353864665, 3574.392353299945, 3685.299793039341, 3691.151035261878, 3691.9446208306895, 3191.7446604271604, 3216.5979252593424, 3238.70851623355, 3245.496947973068, 3246.756493263015, 4481.775911204427, 4561.794719237642, 4565.908681826378, 4583.175028494869, 4604.401427814396, 3996.220736956295, 4202.6847986400835, 4211.873643790691, 4212.347086201613, 4241.130568233505, 4951.579115775164, 4978.87552811179, 4983.302337672692, 5002.549770520634, 5002.699838009731, 3532.876349327761, 3553.5202747629255, 3576.928461430783, 3578.2306804037257, 3590.6947909427467, 5081.23781432788, 5274.92087618686, 5296.629235953485, 5297.947020529822, 5305.442928492491, 3615.403458429382, 3623.782573045573, 3626.5829429615405, 3636.7999760012926, 3645.453182022718, 3684.852605895734, 3687.9262414751556, 3688.55737311519, 3697.815109244581, 3709.870154544578, 4193.18232944579, 4195.181939521825, 4207.158568286355, 4209.0, 4220.662347012231, 4887.36464259644, 4985.740044253347, 5009.974950125226, 5028.446870844205, 5044.461439261061, 1254.6361555149088, 1270.803025531044, 1272.955446559366, 1276.7446510697898, 1278.3288773394042, 785.0696924144793, 803.8995125609299, 808.878668199763, 819.1399031017407, 821.7370441458676, 4195.349720793282, 4258.723182993095, 4325.76208308546, 4359.280718681445, 4410.926864373803, 5111.233315002705, 5117.718525481134, 5120.18077107661, 5132.538071573576, 5132.79468821243, 4384.561543845653, 4392.17724644269, 4398.296272596369, 4401.163778882066, 4409.801558929856, 2565.6017470478632, 2686.395560998799, 2689.273896048056, 2690.6233127362184, 2692.811503194797, 4793.5685788279225, 4802.423709154854, 4808.8797780055775, 4810.95189048105, 4817.373741413594, 5035.169197082514, 5229.607779416483, 5233.215017747369, 5236.423993360727, 5253.50091741284, 4787.257975013878, 4827.565519103227, 4841.273808928689, 4843.975780121147, 4861.51384861511, 5091.516305950929, 5107.310513080835, 5110.565601923729, 5116.769745361542, 5125.897482050413, 4760.500147484464, 4998.550130488128, 5011.047900898818, 5011.724355160502, 5014.4484106747495, 4813.687110337817, 4823.3729615149805, 4862.246351815475, 4865.464798872192, 4873.878153046202, 3603.747737658444, 3607.729420293541, 3621.5473065866768, 3632.8728494502566, 3645.799481028569, 5164.561012313995, 5177.8187763428095, 5207.646012036822, 5209.973950130225, 5215.973920130375, 4782.952170478251, 5019.824306149268, 5058.772355243949, 5059.46875578059, 5094.5160209780015, 5045.68812108847, 5058.898822023612, 5059.291699162194, 5059.519345662156, 5088.313077734459, 4870.659053866196, 5001.749912504288, 5010.968364139643, 5011.248312753116, 5023.2214006829, 4842.539958703917, 4940.333055037668, 4993.850184494471, 5039.445660977363, 5088.532061950025, 4910.2880082388565, 4920.769807548113, 4960.900781984412, 4967.453580106113, 4968.900621987612], "value": 3749.461147824577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.2193237824637, 602.9819105426837, 620.8758248350331, 697.9844326504933, 701.5650296815975, 12259.63221103366, 13213.339333033346, 13552.796708049362, 13608.183508989456, 13639.318034098305, 12951.352432378368, 13063.281519516422, 13080.149790263626, 13081.149725267851, 13105.606831795061, 626.2578844069792, 744.114503740547, 766.3983772738402, 766.5745511241258, 771.2287712287713, 778.696308439709, 780.4653812138674, 781.8084569280534, 782.0, 783.2872086401376, 812.3095368936416, 820.4052062254847, 821.5440430561036, 822.5023860564362, 822.6873787960567, 650.847050943028, 790.1703211627796, 805.4402190477621, 813.8901248331458, 818.9754307370729, 601.5758889982552, 602.172013481463, 602.5962605054624, 602.8764103358801, 603.8037637767743, 12526.185797923197, 12530.185537940004, 12531.248125112523, 12547.56083537081, 12555.121141520005, 12079.27524348542, 12199.878001219962, 12342.382880856012, 12407.379631018503, 12851.935740321238, 10579.576816927314, 10752.78494430115, 10756.0, 10819.35083894961, 11190.608328708457, 3986.66113380363, 4056.1076563156353, 4096.283150448689, 4123.690723195772, 4246.7027308088445, 63730.68134659297, 63870.36129638691, 64136.0, 67848.0, 67865.66067169682, 8486.151384861465, 8865.822683546294, 9676.854847177297, 9815.950920245354, 9816.852747208797, 17761.0, 17933.37233196832, 17951.73072403915, 18001.819981800276, 18049.0, 6641.070250164981, 6657.1012913257055, 6666.133402657623, 6667.199936007613, 6675.732970681215, 3704.111013356775, 3867.0525721198487, 3868.709846761504, 3963.0, 3966.702497312713, 2758.6965433802266, 2853.1583182961076, 2853.2866783304175, 2869.0, 2871.25347409675, 473.1979295094781, 487.6269653714911, 488.155491000571, 489.3149590573155, 497.8431793984883, 548.3447280499844, 556.4741319453159, 582.6837085987828, 585.1632166002657, 590.7961753195141, 7430.848218526137, 7567.772966811004, 7870.212978702199, 8080.71717489885, 8175.877361839577, 427.3248267736968, 466.99533004670195, 503.92189210672404, 505.0000998023933, 525.13352967603, 3643.85424583019, 3795.791231482295, 3829.1384438501673, 3858.8456461741216, 4033.2941735196223, 93433.5328323354, 102218.48890755499, 102726.0, 103266.48366758118, 106658.46670766751, 50626.49373506291, 50639.746801265755, 52965.0, 53154.73422632862, 95969.0, 43289.783551082044, 45632.0, 73496.63251683707, 73621.6318918402, 83367.0, 8160.8367832641825, 8394.538300393537, 8444.113368096507, 8470.49177049379, 8615.569221538773, 39991.60008399879, 42902.570974291106, 42999.0, 43578.34632480452, 44650.0, 54283.72858135684, 61382.38617613767, 61775.69112154411, 62536.687316563126, 63767.0, 10076.395416275047, 10094.091531762177, 10318.122959548522, 10368.170546356425, 10591.89408105909, 12333.321667308384, 12832.230066195685, 12948.8057679133, 12983.0, 13514.39185236647, 6814.591124532544, 10724.678259652223, 11645.6506304811, 11804.0, 11808.586699465477, 11693.0, 11982.520699172284, 12183.573574924834, 12367.072469564999, 12547.43536540876, 11360.375179365214, 11394.25937314072, 11844.76310473803, 11853.644390668294, 12029.879701202875, 9663.565139568596, 9914.801703966024, 9953.402795832273, 10033.297669163088, 10056.748581285527, 9812.607495700093, 10035.849462257926, 10077.546510406903, 10204.795904081728, 10222.1822254218], "value": 6383.784377496497, "unit": "score"}], "name": "dromaeo_css", "value": 6273.549111979297, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0, 115.0, 113.0, 116.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 122.0, 185.0, 123.0, 125.0, 144.0, 127.0, 160.0, 121.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 164.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 102.0, 75.0, 75.0, 75.0, 74.0, 105.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 128.0, 85.0, 86.0, 86.0, 121.0, 86.0, 85.0, 129.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 64.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 83.0, 79.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 131.0, 130.0, 129.0, 131.0, 128.0, 148.0, 138.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 166.0, 164.0, 170.0, 165.0, 166.0, 165.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 69.0, 67.0, 67.0, 67.0, 65.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1524.2, "alertThreshold": 2.0}]} 13:02:07 INFO - Return code: 0 13:02:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:02:07 INFO - # TBPL SUCCESS # 13:02:07 INFO - Running post-action listener: _resource_record_post_action 13:02:07 INFO - [mozharness: 2016-08-08 20:02:07.317486Z] Finished run-tests step (success) 13:02:07 INFO - Running post-run listener: _resource_record_post_run 13:02:07 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525017088; Read time: 16; Write time: 577192 13:02:07 INFO - TinderboxPrint: CPU usage
13.0% 13:02:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:02:07 INFO - TinderboxPrint: I/O write bytes / time
525,017,088 / 577,192 13:02:07 INFO - TinderboxPrint: CPU idle
8,326.5 (87.0%) 13:02:07 INFO - TinderboxPrint: CPU user
1,198.6 (12.5%) 13:02:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:02:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 183111680; Read time: 0; Write time: 238964 13:02:07 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 286617600; Read time: 0; Write time: 315896 13:02:07 INFO - Running post-run listener: _upload_blobber_files 13:02:07 INFO - Blob upload gear active. 13:02:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:02:07 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 13:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:02:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:02:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:02:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:02:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:09 INFO - (blobuploader) - INFO - Done attempting. 13:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:02:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:09 INFO - (blobuploader) - INFO - Done attempting. 13:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:14 INFO - (blobuploader) - INFO - Done attempting. 13:02:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:02:14 INFO - Return code: 0 13:02:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:02:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:02:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c60e25c78b577d2e8937ed0d30849adb7ccb824c29d1136c276e95beb2a60c32be9f46fdbefab190264493b7678d9903a4dcca8792d2074d422cbef44ab8580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ccd89e6baeeb675c75d5b1dd70772d9591c5d84c6e873ad28ca5ee0df6a319bb84b5f34d5130923c4962b59ec93246a18d6e06e1cd93bf6ab3729a5ecd7afbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf3c92c24ea6f991714a716344a43e3ac4a4a30c22504bc8321e3b885a08e6b4952c79df5f748d3f5db89662042363c2d0aa23c96310a3c73f8e8a7008d9e961"} 13:02:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:02:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:02:14 INFO - Contents: 13:02:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c60e25c78b577d2e8937ed0d30849adb7ccb824c29d1136c276e95beb2a60c32be9f46fdbefab190264493b7678d9903a4dcca8792d2074d422cbef44ab8580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ccd89e6baeeb675c75d5b1dd70772d9591c5d84c6e873ad28ca5ee0df6a319bb84b5f34d5130923c4962b59ec93246a18d6e06e1cd93bf6ab3729a5ecd7afbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf3c92c24ea6f991714a716344a43e3ac4a4a30c22504bc8321e3b885a08e6b4952c79df5f748d3f5db89662042363c2d0aa23c96310a3c73f8e8a7008d9e961"} 13:02:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:02:14 INFO - Copying logs to upload dir... 13:02:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:02:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.184672 ========= master_lag: 11.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-08-08 13:02:25.291956) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 13:02:25.295769) ========= 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=0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836 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-Non-PGO/sha512/2c60e25c78b577d2e8937ed0d30849adb7ccb824c29d1136c276e95beb2a60c32be9f46fdbefab190264493b7678d9903a4dcca8792d2074d422cbef44ab8580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ccd89e6baeeb675c75d5b1dd70772d9591c5d84c6e873ad28ca5ee0df6a319bb84b5f34d5130923c4962b59ec93246a18d6e06e1cd93bf6ab3729a5ecd7afbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf3c92c24ea6f991714a716344a43e3ac4a4a30c22504bc8321e3b885a08e6b4952c79df5f748d3f5db89662042363c2d0aa23c96310a3c73f8e8a7008d9e961"} build_url:https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010027 build_url: 'https://queue.taskcluster.net/v1/task/E1UyKGAzRu2PCFqrzpYitA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c60e25c78b577d2e8937ed0d30849adb7ccb824c29d1136c276e95beb2a60c32be9f46fdbefab190264493b7678d9903a4dcca8792d2074d422cbef44ab8580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ccd89e6baeeb675c75d5b1dd70772d9591c5d84c6e873ad28ca5ee0df6a319bb84b5f34d5130923c4962b59ec93246a18d6e06e1cd93bf6ab3729a5ecd7afbc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf3c92c24ea6f991714a716344a43e3ac4a4a30c22504bc8321e3b885a08e6b4952c79df5f748d3f5db89662042363c2d0aa23c96310a3c73f8e8a7008d9e961"}' ========= master_lag: 0.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 13:02:25.560501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 13:02:25.560863) ========= 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=0333a256a5e4f052382dd180000001b1-1470678514.288593-734236836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 13:02:25.583711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 13:02:25.584213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 13:02:25.586720) ========= ========= Total master_lag: 11.51 =========