builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1468606940.6 results: success (0) buildid: 20160715072837 builduid: 334663f4f647416cb3f13fccfe4d5a75 revision: 2f9e69c982f1e67887a1834b36ff0af4ababb3af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.595657) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.596152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.596427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.611698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.612095) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 11:22:21-- 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% 227M=0s 2016-07-15 11:22:21 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.737484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.737795) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019032 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:20.788985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 11:22:20.789386) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f9e69c982f1e67887a1834b36ff0af4ababb3af --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 2f9e69c982f1e67887a1834b36ff0af4ababb3af --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 11:22:21,234 truncating revision to first 12 chars 2016-07-15 11:22:21,234 Setting DEBUG logging. 2016-07-15 11:22:21,234 attempt 1/10 2016-07-15 11:22:21,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f9e69c982f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 11:22:22,092 unpacking tar archive at: fx-team-2f9e69c982f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.181638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 11:22:21.984595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:21.984926) ========= script_repo_revision: 2f9e69c982f1e67887a1834b36ff0af4ababb3af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:21.985329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:21.985593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:22:21.995157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-15 11:22:21.995543) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:22 INFO - MultiFileLogger online at 20160715 11:22:22 in /builds/slave/test 11:22:22 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 11:22:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:22 INFO - {'append_to_log': False, 11:22:22 INFO - 'base_work_dir': '/builds/slave/test', 11:22:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:22:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:22 INFO - 'branch': 'Fx-Team-Non-PGO', 11:22:22 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:22 INFO - 'config_files': ('talos/linux_config.py',), 11:22:22 INFO - 'default_actions': ('clobber', 11:22:22 INFO - 'read-buildbot-config', 11:22:22 INFO - 'download-and-extract', 11:22:22 INFO - 'populate-webroot', 11:22:22 INFO - 'create-virtualenv', 11:22:22 INFO - 'install', 11:22:22 INFO - 'run-tests'), 11:22:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:22 INFO - 'download_minidump_stackwalk': True, 11:22:22 INFO - 'download_symbols': 'ondemand', 11:22:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:22 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:22 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:22 INFO - 'installer_path': 'installer.exe', 11:22:22 INFO - 'log_level': 'info', 11:22:22 INFO - 'log_name': 'talos', 11:22:22 INFO - 'log_to_console': True, 11:22:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:22 INFO - 'opt_config_files': (), 11:22:22 INFO - 'pip_index': False, 11:22:22 INFO - 'sps_profile': False, 11:22:22 INFO - 'sps_profile_interval': 0, 11:22:22 INFO - 'suite': 'dromaeojs', 11:22:22 INFO - 'system_bits': '32', 11:22:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:22 INFO - 'title': 'talos-linux64-ix-069', 11:22:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:22 INFO - 'use_talos_json': True, 11:22:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:22 INFO - 'work_dir': 'build'} 11:22:22 INFO - ##### 11:22:22 INFO - ##### Running clobber step. 11:22:22 INFO - ##### 11:22:22 INFO - Running pre-action listener: _resource_record_pre_action 11:22:22 INFO - Running main action method: clobber 11:22:22 INFO - rmtree: /builds/slave/test/build 11:22:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:23 INFO - Running post-action listener: _resource_record_post_action 11:22:23 INFO - ##### 11:22:23 INFO - ##### Finished clobber step (success) 11:22:23 INFO - ##### 11:22:23 INFO - ##### 11:22:23 INFO - ##### Running read-buildbot-config step. 11:22:23 INFO - ##### 11:22:23 INFO - Running pre-action listener: _resource_record_pre_action 11:22:23 INFO - Running main action method: read_buildbot_config 11:22:23 INFO - Using buildbot properties: 11:22:23 INFO - { 11:22:23 INFO - "project": "", 11:22:23 INFO - "product": "firefox", 11:22:23 INFO - "script_repo_revision": "production", 11:22:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:22:23 INFO - "repository": "", 11:22:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:22:23 INFO - "buildid": "20160715072837", 11:22:23 INFO - "pgo_build": "False", 11:22:23 INFO - "basedir": "/builds/slave/test", 11:22:23 INFO - "buildnumber": 1808, 11:22:23 INFO - "slavename": "talos-linux64-ix-069", 11:22:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:22:23 INFO - "platform": "ubuntu64_hw", 11:22:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:22:23 INFO - "branch": "fx-team", 11:22:23 INFO - "repo_path": "integration/fx-team", 11:22:23 INFO - "revision": "2f9e69c982f1e67887a1834b36ff0af4ababb3af", 11:22:23 INFO - "stage_platform": "linux64", 11:22:23 INFO - "builduid": "334663f4f647416cb3f13fccfe4d5a75", 11:22:23 INFO - "slavebuilddir": "test" 11:22:23 INFO - } 11:22:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:22:23 INFO - Running post-action listener: _resource_record_post_action 11:22:23 INFO - ##### 11:22:23 INFO - ##### Finished read-buildbot-config step (success) 11:22:23 INFO - ##### 11:22:23 INFO - ##### 11:22:23 INFO - ##### Running download-and-extract step. 11:22:23 INFO - ##### 11:22:23 INFO - Running pre-action listener: _resource_record_pre_action 11:22:23 INFO - Running main action method: download_and_extract 11:22:23 INFO - mkdir: /builds/slave/test/build/tests 11:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:23 INFO - https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:22:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:22:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:22:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:22:24 INFO - Downloaded 1361 bytes. 11:22:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:22:24 INFO - Using the following test package requirements: 11:22:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:22:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'jsshell-linux-x86_64.zip'], 11:22:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:22:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:22:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:24 INFO - https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:25 INFO - Downloaded 22757261 bytes. 11:22:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:22:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:22:26 INFO - Return code: 0 11:22:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:26 INFO - https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:22:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:22:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:27 INFO - Downloaded 22757261 bytes. 11:22:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:22:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:22:28 INFO - Return code: 0 11:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:28 INFO - https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:22:29 INFO - Downloaded 14403317 bytes. 11:22:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:22:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:22:30 INFO - Return code: 0 11:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:30 INFO - https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:22:31 INFO - Downloaded 57071083 bytes. 11:22:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:22:31 INFO - mkdir: /builds/slave/test/properties 11:22:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:31 INFO - Contents: 11:22:31 INFO - build_url:https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:22:32 INFO - Running post-action listener: _resource_record_post_action 11:22:32 INFO - Running post-action listener: set_extra_try_arguments 11:22:32 INFO - ##### 11:22:32 INFO - ##### Finished download-and-extract step (success) 11:22:32 INFO - ##### 11:22:32 INFO - ##### 11:22:32 INFO - ##### Running populate-webroot step. 11:22:32 INFO - ##### 11:22:32 INFO - Running pre-action listener: _resource_record_pre_action 11:22:32 INFO - Running main action method: populate_webroot 11:22:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:32 INFO - '--tppagecycles', 11:22:32 INFO - '7'], 11:22:32 INFO - 'tests': ['tsvgm']}}, 11:22:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['damp', 'tps']}, 11:22:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'tests': ['damp', 'tps']}, 11:22:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['dromaeo_dom']}, 11:22:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['basic_compositor_video']}, 11:22:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:22:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['a11yr', 11:22:32 INFO - 'ts_paint', 11:22:32 INFO - 'tpaint', 11:22:32 INFO - 'sessionrestore', 11:22:32 INFO - 'sessionrestore_no_auto_restore', 11:22:32 INFO - 'tabpaint']}, 11:22:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:32 INFO - 'ts_paint', 11:22:32 INFO - 'tpaint', 11:22:32 INFO - 'sessionrestore', 11:22:32 INFO - 'sessionrestore_no_auto_restore', 11:22:32 INFO - 'tabpaint']}, 11:22:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:32 INFO - 'ts_paint', 11:22:32 INFO - 'tpaint', 11:22:32 INFO - 'sessionrestore', 11:22:32 INFO - 'sessionrestore_no_auto_restore', 11:22:32 INFO - 'tabpaint']}, 11:22:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:32 INFO - 'ts_paint', 11:22:32 INFO - 'tpaint', 11:22:32 INFO - 'sessionrestore', 11:22:32 INFO - 'sessionrestore_no_auto_restore', 11:22:32 INFO - 'tabpaint']}, 11:22:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['a11yr', 11:22:32 INFO - 'ts_paint', 11:22:32 INFO - 'tpaint', 11:22:32 INFO - 'sessionrestore', 11:22:32 INFO - 'sessionrestore_no_auto_restore', 11:22:32 INFO - 'tabpaint']}, 11:22:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['a11yr', 11:22:32 INFO - 'ts_paint', 11:22:32 INFO - 'tpaint', 11:22:32 INFO - 'sessionrestore', 11:22:32 INFO - 'sessionrestore_no_auto_restore', 11:22:32 INFO - 'tabpaint']}, 11:22:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['tsvgx', 11:22:32 INFO - 'tsvgr_opacity', 11:22:32 INFO - 'tart', 11:22:32 INFO - 'tscrollx', 11:22:32 INFO - 'cart']}, 11:22:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:32 INFO - 'tsvgr_opacity', 11:22:32 INFO - 'tart', 11:22:32 INFO - 'tscrollx', 11:22:32 INFO - 'cart']}, 11:22:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'talos_options': ['--disable-e10s'], 11:22:32 INFO - 'tests': ['tp5o']}, 11:22:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'tests': ['tp5o']}, 11:22:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'talos_options': ['--disable-e10s', 11:22:32 INFO - '--xperf_path', 11:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:32 INFO - 'tests': ['tp5n']}, 11:22:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:32 INFO - 'talos_options': ['--xperf_path', 11:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:32 INFO - 'tests': ['tp5n']}}, 11:22:32 INFO - 'talos.zip': {'path': '', 11:22:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:32 INFO - Running post-action listener: _resource_record_post_action 11:22:32 INFO - ##### 11:22:32 INFO - ##### Finished populate-webroot step (success) 11:22:32 INFO - ##### 11:22:32 INFO - ##### 11:22:32 INFO - ##### Running create-virtualenv step. 11:22:32 INFO - ##### 11:22:32 INFO - Running pre-action listener: _resource_record_pre_action 11:22:32 INFO - Running main action method: create_virtualenv 11:22:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:32 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 11:22:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:32 INFO - Using real prefix '/usr' 11:22:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:34 INFO - Installing pip.................done. 11:22:34 INFO - Return code: 0 11:22:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 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 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:34 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 11:22:34 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 11:22:34 INFO - Using env: {'DISPLAY': ':0', 11:22:34 INFO - 'HOME': '/home/cltbld', 11:22:34 INFO - 'LANG': 'en_US.UTF-8', 11:22:34 INFO - 'LANGUAGE': 'en_US:en', 11:22:34 INFO - 'LOGNAME': 'cltbld', 11:22:34 INFO - 'MAIL': '/var/mail/cltbld', 11:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:34 INFO - 'MOZ_NO_REMOTE': '1', 11:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:34 INFO - 'NO_EM_RESTART': '1', 11:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:34 INFO - 'PWD': '/builds/slave/test', 11:22:34 INFO - 'SHELL': '/bin/bash', 11:22:34 INFO - 'SHLVL': '1', 11:22:34 INFO - 'TERM': 'linux', 11:22:34 INFO - 'TMOUT': '86400', 11:22:34 INFO - 'USER': 'cltbld', 11:22:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:34 INFO - '_': '/tools/buildbot/bin/python'} 11:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:34 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 11:22:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 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 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:34 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 11:22:34 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 11:22:34 INFO - Using env: {'DISPLAY': ':0', 11:22:34 INFO - 'HOME': '/home/cltbld', 11:22:34 INFO - 'LANG': 'en_US.UTF-8', 11:22:34 INFO - 'LANGUAGE': 'en_US:en', 11:22:34 INFO - 'LOGNAME': 'cltbld', 11:22:34 INFO - 'MAIL': '/var/mail/cltbld', 11:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:34 INFO - 'MOZ_NO_REMOTE': '1', 11:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:34 INFO - 'NO_EM_RESTART': '1', 11:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:34 INFO - 'PWD': '/builds/slave/test', 11:22:34 INFO - 'SHELL': '/bin/bash', 11:22:34 INFO - 'SHLVL': '1', 11:22:34 INFO - 'TERM': 'linux', 11:22:34 INFO - 'TMOUT': '86400', 11:22:34 INFO - 'USER': 'cltbld', 11:22:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:34 INFO - '_': '/tools/buildbot/bin/python'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 INFO - Downloading/unpacking psutil>=3.1.1 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:37 INFO - Installing collected packages: psutil 11:22:37 INFO - Running setup.py install for psutil 11:22:37 INFO - building 'psutil._psutil_linux' extension 11:22:37 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 11:22:37 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 11:22:37 INFO - building 'psutil._psutil_posix' extension 11:22:37 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 11:22:37 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 11:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:37 INFO - Successfully installed psutil 11:22:37 INFO - Cleaning up... 11:22:37 INFO - Return code: 0 11:22:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:22:37 INFO - Using env: {'DISPLAY': ':0', 11:22:37 INFO - 'HOME': '/home/cltbld', 11:22:37 INFO - 'LANG': 'en_US.UTF-8', 11:22:37 INFO - 'LANGUAGE': 'en_US:en', 11:22:37 INFO - 'LOGNAME': 'cltbld', 11:22:37 INFO - 'MAIL': '/var/mail/cltbld', 11:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:37 INFO - 'MOZ_NO_REMOTE': '1', 11:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:37 INFO - 'NO_EM_RESTART': '1', 11:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:37 INFO - 'PWD': '/builds/slave/test', 11:22:37 INFO - 'SHELL': '/bin/bash', 11:22:37 INFO - 'SHLVL': '1', 11:22:37 INFO - 'TERM': 'linux', 11:22:37 INFO - 'TMOUT': '86400', 11:22:37 INFO - 'USER': 'cltbld', 11:22:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:37 INFO - '_': '/tools/buildbot/bin/python'} 11:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:39 INFO - Installing collected packages: mozsystemmonitor 11:22:39 INFO - Running setup.py install for mozsystemmonitor 11:22:39 INFO - Successfully installed mozsystemmonitor 11:22:39 INFO - Cleaning up... 11:22:40 INFO - Return code: 0 11:22:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:22:40 INFO - Using env: {'DISPLAY': ':0', 11:22:40 INFO - 'HOME': '/home/cltbld', 11:22:40 INFO - 'LANG': 'en_US.UTF-8', 11:22:40 INFO - 'LANGUAGE': 'en_US:en', 11:22:40 INFO - 'LOGNAME': 'cltbld', 11:22:40 INFO - 'MAIL': '/var/mail/cltbld', 11:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:40 INFO - 'MOZ_NO_REMOTE': '1', 11:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:40 INFO - 'NO_EM_RESTART': '1', 11:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:40 INFO - 'PWD': '/builds/slave/test', 11:22:40 INFO - 'SHELL': '/bin/bash', 11:22:40 INFO - 'SHLVL': '1', 11:22:40 INFO - 'TERM': 'linux', 11:22:40 INFO - 'TMOUT': '86400', 11:22:40 INFO - 'USER': 'cltbld', 11:22:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:40 INFO - '_': '/tools/buildbot/bin/python'} 11:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:42 INFO - warning: no files found matching '*.txt' 11:22:42 INFO - no previously-included directories found matching 'build' 11:22:42 INFO - no previously-included directories found matching 'dist' 11:22:42 INFO - no previously-included directories found matching '.git*' 11:22:42 INFO - Installing collected packages: jsonschema, functools32 11:22:42 INFO - Running setup.py install for functools32 11:22:42 INFO - warning: no files found matching '*.txt' 11:22:42 INFO - no previously-included directories found matching 'build' 11:22:42 INFO - no previously-included directories found matching 'dist' 11:22:42 INFO - no previously-included directories found matching '.git*' 11:22:42 INFO - Successfully installed jsonschema functools32 11:22:42 INFO - Cleaning up... 11:22:42 INFO - Return code: 0 11:22:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:42 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 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:42 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 11:22:42 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 11:22:42 INFO - Using env: {'DISPLAY': ':0', 11:22:42 INFO - 'HOME': '/home/cltbld', 11:22:42 INFO - 'LANG': 'en_US.UTF-8', 11:22:42 INFO - 'LANGUAGE': 'en_US:en', 11:22:42 INFO - 'LOGNAME': 'cltbld', 11:22:42 INFO - 'MAIL': '/var/mail/cltbld', 11:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:42 INFO - 'MOZ_NO_REMOTE': '1', 11:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:42 INFO - 'NO_EM_RESTART': '1', 11:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:42 INFO - 'PWD': '/builds/slave/test', 11:22:42 INFO - 'SHELL': '/bin/bash', 11:22:42 INFO - 'SHLVL': '1', 11:22:42 INFO - 'TERM': 'linux', 11:22:42 INFO - 'TMOUT': '86400', 11:22:42 INFO - 'USER': 'cltbld', 11:22:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:42 INFO - '_': '/tools/buildbot/bin/python'} 11:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:44 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 11:22:44 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 11:22:44 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 11:22:44 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 11:22:44 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 11:22:44 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 11:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:45 INFO - Downloading docopt-0.6.1.tar.gz 11:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:45 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:45 INFO - Running setup.py install for blobuploader 11:22:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:45 INFO - Running setup.py install for requests 11:22:45 INFO - Running setup.py install for docopt 11:22:46 INFO - Successfully installed blobuploader requests docopt 11:22:46 INFO - Cleaning up... 11:22:46 INFO - Return code: 0 11:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:46 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 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:46 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 11:22:46 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 11:22:46 INFO - Using env: {'DISPLAY': ':0', 11:22:46 INFO - 'HOME': '/home/cltbld', 11:22:46 INFO - 'LANG': 'en_US.UTF-8', 11:22:46 INFO - 'LANGUAGE': 'en_US:en', 11:22:46 INFO - 'LOGNAME': 'cltbld', 11:22:46 INFO - 'MAIL': '/var/mail/cltbld', 11:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:46 INFO - 'MOZ_NO_REMOTE': '1', 11:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:46 INFO - 'NO_EM_RESTART': '1', 11:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:46 INFO - 'PWD': '/builds/slave/test', 11:22:46 INFO - 'SHELL': '/bin/bash', 11:22:46 INFO - 'SHLVL': '1', 11:22:46 INFO - 'TERM': 'linux', 11:22:46 INFO - 'TMOUT': '86400', 11:22:46 INFO - 'USER': 'cltbld', 11:22:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:46 INFO - '_': '/tools/buildbot/bin/python'} 11:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:46 INFO - Running setup.py (path:/tmp/pip-U18bhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:46 INFO - Running setup.py (path:/tmp/pip-EkEBe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:46 INFO - Running setup.py (path:/tmp/pip-EsQZjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:46 INFO - Running setup.py (path:/tmp/pip-aFEJ42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:46 INFO - Running setup.py (path:/tmp/pip-cKhiqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:46 INFO - Running setup.py (path:/tmp/pip-2op2va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:46 INFO - Running setup.py (path:/tmp/pip-CBlXsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:46 INFO - Running setup.py (path:/tmp/pip-W6r83z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:46 INFO - Running setup.py (path:/tmp/pip-504uSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:46 INFO - Running setup.py (path:/tmp/pip-EmLF4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:47 INFO - Running setup.py (path:/tmp/pip-_bN5eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:47 INFO - Running setup.py (path:/tmp/pip-ElYqIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:47 INFO - Running setup.py (path:/tmp/pip-lrddwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:47 INFO - Running setup.py (path:/tmp/pip-fZIdfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:47 INFO - Running setup.py (path:/tmp/pip-eHu_3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:47 INFO - Running setup.py (path:/tmp/pip-7COrsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:47 INFO - Running setup.py (path:/tmp/pip-y50qLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:47 INFO - Running setup.py install for manifestparser 11:22:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:47 INFO - Running setup.py install for mozcrash 11:22:47 INFO - Running setup.py install for mozdebug 11:22:47 INFO - Running setup.py install for mozdevice 11:22:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:22:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:47 INFO - Running setup.py install for mozfile 11:22:48 INFO - Running setup.py install for mozhttpd 11:22:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Running setup.py install for mozinfo 11:22:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Running setup.py install for mozInstall 11:22:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Running setup.py install for mozleak 11:22:48 INFO - Running setup.py install for mozlog 11:22:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Running setup.py install for moznetwork 11:22:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Running setup.py install for mozprocess 11:22:48 INFO - Running setup.py install for mozprofile 11:22:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:48 INFO - Running setup.py install for mozrunner 11:22:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:49 INFO - Running setup.py install for mozscreenshot 11:22:49 INFO - Running setup.py install for moztest 11:22:49 INFO - Running setup.py install for mozversion 11:22:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:49 INFO - Cleaning up... 11:22:49 INFO - Return code: 0 11:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:49 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 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:49 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 11:22:49 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 11:22:49 INFO - Using env: {'DISPLAY': ':0', 11:22:49 INFO - 'HOME': '/home/cltbld', 11:22:49 INFO - 'LANG': 'en_US.UTF-8', 11:22:49 INFO - 'LANGUAGE': 'en_US:en', 11:22:49 INFO - 'LOGNAME': 'cltbld', 11:22:49 INFO - 'MAIL': '/var/mail/cltbld', 11:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:49 INFO - 'MOZ_NO_REMOTE': '1', 11:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:49 INFO - 'NO_EM_RESTART': '1', 11:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:49 INFO - 'PWD': '/builds/slave/test', 11:22:49 INFO - 'SHELL': '/bin/bash', 11:22:49 INFO - 'SHLVL': '1', 11:22:49 INFO - 'TERM': 'linux', 11:22:49 INFO - 'TMOUT': '86400', 11:22:49 INFO - 'USER': 'cltbld', 11:22:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:49 INFO - '_': '/tools/buildbot/bin/python'} 11:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:49 INFO - Running setup.py (path:/tmp/pip-FgDZFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:49 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)) 11:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:49 INFO - Running setup.py (path:/tmp/pip-49XgN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:49 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)) 11:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:49 INFO - Running setup.py (path:/tmp/pip-sz546n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:49 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)) 11:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:49 INFO - Running setup.py (path:/tmp/pip-gQIhKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:49 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)) 11:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:49 INFO - Running setup.py (path:/tmp/pip-6UCJeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:49 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)) 11:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:49 INFO - Running setup.py (path:/tmp/pip-DwtvzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:49 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)) 11:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:49 INFO - Running setup.py (path:/tmp/pip-miJePG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:50 INFO - Running setup.py (path:/tmp/pip-JhytaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:50 INFO - Running setup.py (path:/tmp/pip-EZ7cxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:50 INFO - Running setup.py (path:/tmp/pip-ebx9o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:50 INFO - Running setup.py (path:/tmp/pip-DLzcmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:50 INFO - Running setup.py (path:/tmp/pip-4_ZuJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:50 INFO - Running setup.py (path:/tmp/pip-CMD6No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:50 INFO - Running setup.py (path:/tmp/pip-wEe8Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:50 INFO - Running setup.py (path:/tmp/pip-BGdCV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:50 INFO - Running setup.py (path:/tmp/pip-5YjwXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:50 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)) 11:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:50 INFO - Running setup.py (path:/tmp/pip-oriTgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:50 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)) 11:22:50 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)) 11:22:50 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)) 11:22:50 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)) 11:22:50 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)) 11:22:50 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)) 11:22:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:52 INFO - Downloading blessings-1.6.tar.gz 11:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:52 INFO - Installing collected packages: blessings 11:22:52 INFO - Running setup.py install for blessings 11:22:52 INFO - Successfully installed blessings 11:22:52 INFO - Cleaning up... 11:22:52 INFO - Return code: 0 11:22:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:53 INFO - Reading from file tmpfile_stdout 11:22:53 INFO - Current package versions: 11:22:53 INFO - argparse == 1.2.1 11:22:53 INFO - blessings == 1.6 11:22:53 INFO - blobuploader == 1.2.4 11:22:53 INFO - docopt == 0.6.1 11:22:53 INFO - functools32 == 3.2.3-2 11:22:53 INFO - jsonschema == 2.5.1 11:22:53 INFO - manifestparser == 1.1 11:22:53 INFO - mozInstall == 1.12 11:22:53 INFO - mozcrash == 0.17 11:22:53 INFO - mozdebug == 0.1 11:22:53 INFO - mozdevice == 0.48 11:22:53 INFO - mozfile == 1.2 11:22:53 INFO - mozhttpd == 0.7 11:22:53 INFO - mozinfo == 0.9 11:22:53 INFO - mozleak == 0.1 11:22:53 INFO - mozlog == 3.2 11:22:53 INFO - moznetwork == 0.27 11:22:53 INFO - mozprocess == 0.23 11:22:53 INFO - mozprofile == 0.28 11:22:53 INFO - mozrunner == 6.12 11:22:53 INFO - mozscreenshot == 0.1 11:22:53 INFO - mozsystemmonitor == 0.3 11:22:53 INFO - moztest == 0.7 11:22:53 INFO - mozversion == 1.4 11:22:53 INFO - psutil == 3.1.1 11:22:53 INFO - requests == 1.2.3 11:22:53 INFO - wsgiref == 0.1.2 11:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:53 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 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:53 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 11:22:53 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 11:22:53 INFO - Using env: {'DISPLAY': ':0', 11:22:53 INFO - 'HOME': '/home/cltbld', 11:22:53 INFO - 'LANG': 'en_US.UTF-8', 11:22:53 INFO - 'LANGUAGE': 'en_US:en', 11:22:53 INFO - 'LOGNAME': 'cltbld', 11:22:53 INFO - 'MAIL': '/var/mail/cltbld', 11:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:53 INFO - 'MOZ_NO_REMOTE': '1', 11:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:53 INFO - 'NO_EM_RESTART': '1', 11:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:53 INFO - 'PWD': '/builds/slave/test', 11:22:53 INFO - 'SHELL': '/bin/bash', 11:22:53 INFO - 'SHLVL': '1', 11:22:53 INFO - 'TERM': 'linux', 11:22:53 INFO - 'TMOUT': '86400', 11:22:53 INFO - 'USER': 'cltbld', 11:22:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:53 INFO - '_': '/tools/buildbot/bin/python'} 11:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 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)) 11:22:53 INFO - Cleaning up... 11:22:53 INFO - Return code: 0 11:22:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', '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 11:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:22:53 INFO - Using env: {'DISPLAY': ':0', 11:22:53 INFO - 'HOME': '/home/cltbld', 11:22:53 INFO - 'LANG': 'en_US.UTF-8', 11:22:53 INFO - 'LANGUAGE': 'en_US:en', 11:22:53 INFO - 'LOGNAME': 'cltbld', 11:22:53 INFO - 'MAIL': '/var/mail/cltbld', 11:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:53 INFO - 'MOZ_NO_REMOTE': '1', 11:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:53 INFO - 'NO_EM_RESTART': '1', 11:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:53 INFO - 'PWD': '/builds/slave/test', 11:22:53 INFO - 'SHELL': '/bin/bash', 11:22:53 INFO - 'SHLVL': '1', 11:22:53 INFO - 'TERM': 'linux', 11:22:53 INFO - 'TMOUT': '86400', 11:22:53 INFO - 'USER': 'cltbld', 11:22:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:53 INFO - '_': '/tools/buildbot/bin/python'} 11:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:53 INFO - Cleaning up... 11:22:53 INFO - Return code: 0 11:22:53 INFO - Running post-action listener: _resource_record_post_action 11:22:53 INFO - Running post-action listener: _start_resource_monitoring 11:22:53 INFO - Starting resource monitoring. 11:22:53 INFO - ##### 11:22:53 INFO - ##### Finished create-virtualenv step (success) 11:22:53 INFO - ##### 11:22:53 INFO - ##### 11:22:53 INFO - ##### Running install step. 11:22:53 INFO - ##### 11:22:53 INFO - Running pre-action listener: _resource_record_pre_action 11:22:53 INFO - Running main action method: install 11:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:53 INFO - Reading from file tmpfile_stdout 11:22:53 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:53 INFO - Reading from file tmpfile_stdout 11:22:53 INFO - Output received: 11:22:53 INFO - Usage: mozinstall [options] installer 11:22:53 INFO - Options: 11:22:53 INFO - -h, --help show this help message and exit 11:22:53 INFO - -d DEST, --destination=DEST 11:22:53 INFO - Directory to install application into. [default: 11:22:53 INFO - "/builds/slave/test"] 11:22:53 INFO - --app=APP Application being installed. [default: firefox] 11:22:53 INFO - mkdir: /builds/slave/test/build/application 11:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:23:10 INFO - Reading from file tmpfile_stdout 11:23:10 INFO - Output received: 11:23:10 INFO - /builds/slave/test/build/application/firefox/firefox 11:23:10 INFO - Running post-action listener: _resource_record_post_action 11:23:10 INFO - ##### 11:23:10 INFO - ##### Finished install step (success) 11:23:10 INFO - ##### 11:23:10 INFO - ##### 11:23:10 INFO - ##### Running run-tests step. 11:23:10 INFO - ##### 11:23:10 INFO - Running pre-action listener: _resource_record_pre_action 11:23:10 INFO - Running main action method: run_tests 11:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:10 INFO - Python 2.7.3 11:23:10 INFO - Return code: 0 11:23:10 INFO - grabbing minidump binary from tooltool 11:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:10 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 0x22a63b0>, '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 0x22a72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:10 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 11:23:10 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 11:23:10 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 11:23:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:10 INFO - Return code: 0 11:23:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:23:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:23:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:10 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/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:23:10 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/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:23:10 INFO - Using env: {'DISPLAY': ':0', 11:23:10 INFO - 'HOME': '/home/cltbld', 11:23:10 INFO - 'LANG': 'en_US.UTF-8', 11:23:10 INFO - 'LANGUAGE': 'en_US:en', 11:23:10 INFO - 'LOGNAME': 'cltbld', 11:23:10 INFO - 'MAIL': '/var/mail/cltbld', 11:23:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:10 INFO - 'MOZ_NO_REMOTE': '1', 11:23:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:10 INFO - 'NO_EM_RESTART': '1', 11:23:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:10 INFO - 'PWD': '/builds/slave/test', 11:23:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:10 INFO - 'SHELL': '/bin/bash', 11:23:10 INFO - 'SHLVL': '1', 11:23:10 INFO - 'TERM': 'linux', 11:23:10 INFO - 'TMOUT': '86400', 11:23:10 INFO - 'USER': 'cltbld', 11:23:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138', 11:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:10 INFO - '_': '/tools/buildbot/bin/python'} 11:23:10 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/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:23:10 INFO - mozversion application_buildid: 20160715072837 11:23:10 INFO - mozversion application_changeset: 2f9e69c982f1e67887a1834b36ff0af4ababb3af 11:23:10 INFO - mozversion application_display_name: Nightly 11:23:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:10 INFO - mozversion application_name: Firefox 11:23:10 INFO - mozversion application_remotingname: firefox 11:23:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:23:10 INFO - mozversion application_vendor: Mozilla 11:23:10 INFO - mozversion application_version: 50.0a1 11:23:10 INFO - mozversion platform_buildid: 20160715072837 11:23:10 INFO - mozversion platform_changeset: 2f9e69c982f1e67887a1834b36ff0af4ababb3af 11:23:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:23:10 INFO - mozversion platform_version: 50.0a1 11:23:10 INFO - using testdate: 1468606990 11:23:10 INFO - actual date: 1468606990 11:23:10 INFO - starting webserver on 'localhost:39953' 11:23:10 INFO - SUITE-START | Running 2 tests 11:23:10 INFO - TEST-START | dromaeo_css 11:23:10 INFO - operating with platform_type : linux_ 11:23:10 INFO - Initialising browser for dromaeo_css test... 11:23:10 INFO - TEST-INFO | started process 24990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1QYQ63/profile http://localhost:39953/getInfo.html) 11:23:14 INFO - PROCESS | 24990 | __metrics Screen width/height:1600/1200 11:23:14 INFO - PROCESS | 24990 | colorDepth:24 11:23:14 INFO - PROCESS | 24990 | Browser inner width/height: 1024/697 11:23:14 INFO - PROCESS | 24990 | __metrics 11:23:15 INFO - PROCESS | 24990 | 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" 11:23:15 INFO - PROCESS | 24990 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:23:16 INFO - PROCESS | 24990 | console.error: PushService: 11:23:16 INFO - PROCESS | 24990 | stateChangeProcessEnqueue: Error transitioning state 11:23:16 INFO - PROCESS | 24990 | UnknownError 11:23:16 INFO - TEST-INFO | 24990: exit 0 11:23:16 INFO - Browser initialized. 11:23:16 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:16 INFO - TEST-INFO | started process 25074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1QYQ63/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:28 INFO - PROCESS | 25074 | RSS: Main: 159211520 11:23:28 INFO - PROCESS | 25074 | 11:24:19 INFO - PROCESS | 25074 | 1468607059875 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] 11:26:32 INFO - PROCESS | 25074 | Cycle 1(1): loaded http://localhost:39953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39953/tests/dromaeo/cssquery-ext.html) 11:26:33 INFO - PROCESS | 25074 | RSS: Main: 265617408 11:26:33 INFO - PROCESS | 25074 | 11:29:36 INFO - PROCESS | 25074 | Cycle 1(1): loaded http://localhost:39953/tests/dromaeo/cssquery-ext.html (next: http://localhost:39953/tests/dromaeo/cssquery-jquery.html) 11:29:37 INFO - PROCESS | 25074 | RSS: Main: 249016320 11:29:37 INFO - PROCESS | 25074 | 11:32:39 INFO - PROCESS | 25074 | Cycle 1(1): loaded http://localhost:39953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39953/tests/dromaeo/cssquery-mootools.html) 11:32:40 INFO - PROCESS | 25074 | RSS: Main: 247435264 11:32:40 INFO - PROCESS | 25074 | 11:35:42 INFO - PROCESS | 25074 | Cycle 1(1): loaded http://localhost:39953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39953/tests/dromaeo/cssquery-prototype.html) 11:35:43 INFO - PROCESS | 25074 | RSS: Main: 236740608 11:35:43 INFO - PROCESS | 25074 | 11:38:46 INFO - PROCESS | 25074 | Cycle 1(1): loaded http://localhost:39953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39953/tests/dromaeo/cssquery-yui.html) 11:38:46 INFO - PROCESS | 25074 | RSS: Main: 225255424 11:38:46 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | Cycle 1(1): loaded http://localhost:39953/tests/dromaeo/cssquery-yui.html (next: http://localhost:39953/tests/dromaeo/cssquery-dojo.html) 11:41:49 INFO - PROCESS | 25074 | RSS: Main: 282689536 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | __start_tp_report 11:41:49 INFO - PROCESS | 25074 | _x_x_mozilla_page_load 11:41:49 INFO - PROCESS | 25074 | _x_x_mozilla_page_load_details 11:41:49 INFO - PROCESS | 25074 | |i|pagename|runs| 11:41:49 INFO - PROCESS | 25074 | |0;dojo.html;2610.2038878142166;2619.017868299388;2637.2879322582908;2660.135455976808;2660.4812061647976;4591;4654.930176047362;4687.765611719413;4721.244600863863;4738.881527961798;4684.508126646704;4733.195356789345;4736.100140973213;4760.166970780108;4769.761511924407;4335.436393268887;4364.803583838735;4423;4449.42157519522;4501.3022981437925;4414.955850441503;4434.933475997863;4458.108378324348;4466.62033727132;4484.058347746977;4117.91764164718;4175.665946724254;4248.702590818644;4297.35539669049;4302.634276086536;4308.67684923632;4312.935305970413;4317.784110794448;4347.673924455678;4383.320585309282;4366.8908277293;4372.125574885035;4383.75889326087;4419.9337009944875;4432.53458386868;4608.493065762764;4628.583427491509;4666.813327466897;4740.762961851928;4752.215884379108;5076.847694569132;5096.490350964911;5119.56483698886;5122.641415100945;5128.974355128238;5097.362829646294;5142.588592912558;5143.897122057575;5155.149400348938;5162.22566615007;4608.677392582521;4710.858674239778;4764.690295130806;4769.189237829577;4833.299171620095;5300.337457817773;5320.893582128413;5321.36143662763;5328.0675881720545;5339.385970613352;4787.664863459524;5057.8229761958155;5058.696478211319;5095.464976177522;5105.15764898795;4924.8276310328965;5044.066847633199;5079.060373830853;5084.669496482717;5084.898302033938;5034.446210916796;5048.3184770056305;5063.443021267658;5067.822626208065;5120;4809.975950120227;5024.748762561857;5029.823956161516;5031.345925029723;5036;3900.2979463696806;3943.428202910562;3946.7631942082994;3950.6839452843706;3965.8215380307956;3533.6819686228364;3565.2156525564333;3568.072301201654;3605.7295702822394;3621.7102631789394;4367.039251364695;4367.868963931087;4368.672349573794;4375.7374557526655;4408.448943882015;4875.268709693503;4887.755612219375;5089.720065396439;5098.490150984871;5136.101182293084;4311.396404503372;4356.259435895905;4364.978175109104;4379.64962802975;4382.561743825592;4571.954280457219;4574.199515084847;4574.222382195035;4608.838690645811;4612.123696497655;4640.883977900579;4799.808007679723;4801.063792560557;4806.807727690853;4808.447028591757;5135.306733591066;5169.586433085419;5189;5191.92212116811;5239.345081864767;4854.053459575349;4855.757212139309;4859.416869975626;4860.562549370574;4902.093112774148;4824.155772739827;4910;4917.85246442593;5136.101182293159;5139.408967968731;5002.324686167321;5036.370453693288;5037.19404895215;5038.697678139323;5079.415867175322;4886.3647725796845;4892.143874821963;4894.143524883202;4895;4919.065377578248;4720.291956206596;4922.1632322505975;4996.125678006407;5052.090623687772;5066.949330506648;4959.70241785494;4971.925421118758;4972.577330926912;5017.147084995487;5024.598032157492;5029.572486338702;5054.7978080876355;5054.873628159326;5055.216441451581;5097.898042039213;4642.558956899089;4695.812167513262;4785.5453731896805;4853.733044682576;4889.828855990166 11:41:49 INFO - PROCESS | 25074 | |1;ext.html;563.4140493886358;577.4773829684135;579.1775678536478;587.7590188022912;590.9143174239734;29919;30437.847810760944;41223.96940076496;42496;42516.78741606295;42718.78640606793;42995.57004429955;43001.78499107508;43067.78466107673;43133.568664313345;7908.130105688384;8056.234657707509;8056.436049476539;8057.919420805775;8065.2741253287195;7565.508241964282;10138.59445622178;10408.63569775058;10434.530446129942;10752.946235268852;10542.683719488428;10546.736331591695;10609.363438193694;10626.893731062668;10651.733706657356;7650.464467487278;10220.131288840457;10382.221333399988;10442.895571044344;10460.79078418435;10058.497075146286;10420.384840349758;10430.634927777492;10431.530581123867;10438.739031524197;40110.39834402486;40611;40611.390829137585;40626.79686601578;40670.38994415086;3017.09487153853;3071.4317851197375;3078.1535077853546;3094.4739394302796;3149.228439032429;29810.850945745133;30326.393472130432;30373.696263037527;30533.610533610357;31449.37101257985;3541.769784963969;3562.1450851795644;3586.085548185196;3592.1378869071496;3604.1710406606367;261965;262190.68904655543;262746;262930;263234;55415;55857.44142558604;56349.71825140848;56368.71815640978;56420.153697694564;33940.49089263663;34936.30127397438;34993.65006349955;36880.81559592239;36887;14470.131792092297;14560.854391456161;14604.488842890449;14647.780283295759;14866.331015104346;9494.905050949541;10442.738931526772;10700.30448020876;11353.886461135284;11391.658250252505;19084.80915190858;19109;19114.80885191158;19141;19160;7036.6481675916;7138.39323657495;7164.176119746296;7191.388731957738;7300.780976570712;772.4168252968973;873.2664561768145;898.7618281155499;901.977450563728;976.0971101731012;27320;27387.315317116834;28310.15069547876;29401.411971760444;30856.382872342427;939.0281059103932;948.6869333120054;955.7945041816043;979.9314048016713;1050.1913526584487;14094;14554.981151319518;14614.269286535631;14778.63053423673;14822.851771482363;400297;401272;403912;404414;404694;50903.745481273094;51200.23199652008;51292;51349.48650513447;51476.22785658218;1083.9620613278498;1216.92698438094;1229.6679896427736;1238.9008879289636;1263.9304838233802;27727.72272277332;28836.134915952556;28849.85575072111;29125;29398.853005734836;48048.519514805805;49531.25703114384;49542;54684.453155467934;54752;364367;370694;370966;371139;372228;33556.49665255072;34693.65524207532;34759.652403476655;34811;37326;33164.33671326608;33229.66770332266;41141.382879256234;43699;43955.560444395145;35413;37006.629933700315;37221.25557488781;37671.24657506889;38250.42624360581;37779.81110094432;37954;37992;38260.42609360806;38918.4162237561;34325;35820.64179358173;35861.64138358583;35982.8200858994;35985.460218096225;31380.529292060182;33716.66283337135;33915.64337426475;34026;34086;24675.383115422257;25045.49909001846;25046.62430063514;25172.72364217238;25445 11:41:49 INFO - PROCESS | 25074 | |2;jquery.html;358.8026585378043;367.3186239525678;373.73651575639167;382.5562347676695;396.5261512492572;16434.753478697814;17698.734518982208;18500.352487662934;18717.438476845684;18724.344647937323;16330;17310.88404087267;17774.200160992754;17869.64260714785;18221.180046897887;5054.646174767759;5250.579953603722;5266.3153790007245;5273.393559740641;5275.947240527584;3798.9620103798884;3857.32496813058;5137.922931156036;6036.245469316335;6166.568340216187;6101.2983506896835;6105.786297479589;6131.356207598183;6135.631862088267;6139.754409823602;5896.321922978848;6121.296050954131;6127.448529632355;6131.785387511438;6137.202163718688;3454.2055327274866;5053.570446512051;5345.812896548641;5350.35795704514;5380.273663055476;20567.8971605141;21097;21098.89450552753;21731.67402488964;21836.672449913265;2031.5124370151204;2106.5470923751313;2123.9787602123934;2151.7848215178515;2158.7949144831373;9272.814543709155;9565.426074435487;9839.409635421898;10174.084332410044;13907.860921390758;1776.635789663116;1793.9192736326897;1827.9268829246814;1828.570285982793;1838.1452624529659;67979.66010169967;73825;74857.62571187163;75573;75819.62090189513;10332.483375831178;10560.894391056145;10643.94678026605;10689.198310126772;10695.144388448905;14609.634759131106;14709.632259193606;14725.484608038882;14738.484153054591;14749.631259218606;7489.176190619028;7775.611219439005;7775.961120194363;7873.960630196812;7880.211978802188;7213.783586492414;7323.157836848724;7362.042934418491;7481.5511069334925;7500.662470188855;4407.471103467605;4491.797869095899;4504.211762941472;4600.953990460052;4611.608013318905;1865.5242913057084;1894.9621007579772;1896.1751638037497;1909.2649330008046;1980.920763169486;796.6096612659755;840.6175190288404;841.5960339037297;865.1348651348651;917.6467060181744;16716.665666686597;16837.663246734995;17469.7379539307;17531;18070.277188912558;836.6402446947749;857.9656813727506;876.3646356391565;882.911708829112;919.7516670499061;9360.251179905592;9850.802983940424;9877.604895804086;9884.258680598983;10028.648997285205;375886;379654;380135;384235;385528;79260;80910;80967.19032809715;81019.59490202629;82047.17952820395;828.8549503836925;871.8038441350645;884.3720958119807;886.0829041941688;899.25361949583;15316.310766015778;15637.609059773597;15784.76322855181;15800;16149.111798851176;38412.61587384091;38884.61115388923;39187;39374.40938385869;40389.59610403976;53224;55498.72250638721;56234.71882640561;56438.1534276978;56592.71703641456;7640.961795190989;7668.884966725392;7707.653155607899;8005.279524842792;8011.559364235023;11855.288682679067;12051.216670916363;12052.216605920587;12187.329696866758;12349.93825030869;10206.183505319408;10561.683149505527;10702;10735.733485216495;10807.837882431613;10685.412302323446;10771.246012779344;10842.620508282173;10927.344359338465;11230.3261804292;10446.112080472942;10788.083012943987;10792.460376981277;10906.34561926287;11112.722181945515;7786.287016856509;7876.251756083163;7955.681772729026;8097.311728503143;8169.428140030141;9726.610935562498;10729.356238625707;10757.623483178051;10975.231733778879;11034 11:41:49 INFO - PROCESS | 25074 | |3;mootools.html;1237.5544803870612;1391.5477469822308;1426.6290764401253;1498.415617909015;1726.775519182507;6850.417714494268;7609.581473018981;7929.286364227226;7948.085970113439;8204.3436525078;7890.250426209515;8095.5952202389935;8096.838063238746;8102.594870256478;8109.91890081099;1852.0739630184908;1911.5985643014983;1915.6073005034004;2228.921987730434;2260.8304377171694;1937.118611031984;2140.7110040144617;2208.293346129239;2211.060299372768;2227.231605096239;2045.4681782736448;2086.791320867916;2094.4030951178916;2100.2229175205193;2100.69539916712;1803.8556915446864;2112.1234687604624;2116.2381542644634;2117.1108134583433;2119.109973811003;2100.1809294375053;2174.92387766429;2175.7280339957506;2190.5618876224657;2191.123550579765;7967.721129760431;7987.201279872024;8000.599970001476;8015.078265999368;8016.559089250089;4433.556644335573;4519.661025423074;4523.411956445641;4523.434570678665;4527.4114365132655;2894.3921776426764;2899.594056832045;2966.7626589872757;2981.195077329109;2995.5207166853415;977.2816979520047;989.9257555683281;995.4873240281261;1014.3660212367271;1782.1445706061163;10633.627823026234;11113.777724445466;11117.499712512956;11159.274647147991;11183.440827958651;3875.1280961783937;3996.760194388346;4077.6330130287824;4078.204750073707;4078.979605102015;8664.740057798275;8744.081871403538;8747.081556436482;8748.475091494403;8757.824843503095;4584.4498660161;4588.701734387254;4596.49438561758;4597.44830620321;4598.88502787433;3665.6151104133683;3846.3845784674318;4259.914801704011;4272.359146128106;4279.101388708344;3438.415469370163;3540.2034542227793;3606.585242697071;3607.981960090183;3612.0428086557085;1014.7919676466307;1022.2231104360591;1026.5637104230673;1047.6909311753052;1052.3896140238644;603.432773193197;625.1778910732372;652.4845372156038;656.7241758461457;751.6617522115071;5201.1678131498775;5285.339332583427;5300.575953923677;5301.946980530222;5542.334919809648;841.8358420108143;886.3352485635774;888.8977767556813;893.1515060692238;905.0496978173023;3344.5819272590925;3478.339115568034;3529.5588051493564;3597.5862775780597;3601.2797440511476;9857.260705447121;10102.09081182697;10158.796824063478;10249.897501024894;10277.9486102569;9999.700008999742;10013.048760367754;10031.949840250898;10079.042490963348;10130.392176469435;7234.819129521804;7257.818554536178;7410.962945185347;7446.66490007951;7472.476926615193;5151.8196863109615;5234.947650523446;5267.578593712417;5268.394134674561;5275;8879.866801997847;9040.593173307085;9124.680636177702;9132.406393584395;9134.908650913405;8873.245774109273;9052.094790521158;9260.351775375659;9314.627414903329;9315.068493150631;6124.326324104256;6669.866602668017;6812.284710105368;6825.863482730417;6982.33667801558;7432.293932076444;7453.888191677238;7458;7462.328390444886;7508.061492313461;6801.693923773343;6805.557638753465;6839.1451068616425;6937.791866244021;6975.162980442379;6774.085498457645;6863.07348507965;6866.485013623898;6939.063226464363;7052;6045.576809623284;6176;6263.655498947602;6282.403171698681;6421.93578064232;4412.646988240997;4454.4877339106415;4475.753833539186;4509.278515437514;4522.796474158737;4348.282533382083;4434.357018232274;4445.599896009375;4534.115847409724;4547.1133129040845 11:41:49 INFO - PROCESS | 25074 | |4;prototype.html;289.41104851626943;291.6150681100947;299.1548874429735;304.9252933031408;308.8563817824711;4801.327814106028;4909.950900490994;4912.38595175603;4948.233023881299;4958.702477851331;4672.64955128365;4845.3216549683075;4848.854534363974;4859.854204373865;4914.97542512287;3855.9421608675893;3859.9807000964956;3862.246861861938;3869.1487872667967;3875.147467557133;3656.341858465475;3744.3821769408014;3859.4210868369687;3881.5342158940966;3913.7456065355805;3758.6617204451595;3808.7143464240294;3811.7331786774935;3822.8853134406013;3826.9808650956707;3824.3116239076953;3830.712696547756;3832.5975772543898;3836.0218144373284;3855.325318069327;3390.7117894978956;3392.8133952632597;3402.7447941404494;3408.5739282589675;3423.880164194266;4682.016776476944;4795.568398844121;4798.640101992364;4835.468098509196;4837.177679794443;4361.520232774392;4381.824727010916;4383.561643835623;4386.166628340605;4404.559544045602;5116.565091967187;5117.1556693145585;5119.462456442095;5134.512221338967;5145.408278048035;3417.265287963075;3630.2393339230453;3633.418653015531;3641.3809652359164;3705.981470092659;5337.332833395825;5381.892362152774;5384.40771515133;5385;5397.946020539823;3728.6949567651645;3734.1598140418187;3751.8744376686886;3758.567764707039;3767.9058023549082;3696.5194524711615;3787.242551489713;3805.448210009533;3811.676007539335;3814.1608846053823;4273.145370925828;4288.2495563276925;4297.419848320436;4307.246231909403;4324.113556720865;4859.271109333628;5055.418626857885;5072.644914855999;5088.262201980692;5101.540861322499;1245.9190152640049;1273.9745205095846;1280.8334916460988;1282.5062350994933;1286.5754301080622;804.9315808156372;823.6581818545357;836.3225787112458;837.1712005114892;842.6797816829566;4036.5156181258435;4045.37296719009;4047.98800299925;4049.959500405017;4056.7565946043333;4648.790804413809;4663.510331415153;4671.6262698984;4684.882877928011;4686.7656617169005;3986.621270979252;4005.1589166275407;4021.416894550274;4024.1146947671464;4034.636882680514;2335.3344296875307;2486.365976675936;2492.7660807900206;2498.1880888711244;2507.6489291499206;4389.4513185851765;4414.359917811899;4437.556244375602;4459.710118842329;4465.732056076646;4704.670673052922;4712.458067322302;4719.504452032487;4780.163471392492;4795.968866693677;4407.713498622579;4465.866024019285;4645.861763867874;5044.764032811838;5062.7468626568525;5352.197170424468;5381.35868560093;5382.246485491956;5382.381026182039;5396;5246.816361427332;5259.15853463444;5267.473252674702;5271.578273738015;5276.5251127398715;4937.46938449082;4964.280179373898;5017.54842064216;5042.798288068583;5044.394672639307;3733.272011957642;3747.3254814133716;3773.566039905446;3781.829817658267;3782.3759079752635;5124.743762811919;5340.225667278145;5379.488948549882;5380.973095134499;5410.729463526886;5012.749362531786;5122.615803814654;5134.845954621367;5159.613029022763;5167.302414174038;5121.513456221653;5131.512506311894;5145;5168.8449346519665;5173.275741396133;4865.513448655106;5055.545000949932;5097.745112744422;5103.081445339874;5127.359080114986;5124.897502050013;5136.922946155736;5152.639315247897;5159.226116082467;5170.371333030083;5059.544640982329;5060.924086138784;5066.707989462663;5071.18860982241;5075.467075956972 11:41:49 INFO - PROCESS | 25074 | |5;yui.html;638.0907207229696;656.7602824968887;665.3612531969309;723.9746608868691;758.1925249609168;11960.401979901002;12131.818022729643;12733.490660373585;12772.872271277285;13304.201747895133;13443.32783360833;13500.527481538149;13563.050586458952;13615.591532254024;13635.863641363583;638.3712043637014;780.5667854340838;784.0669603172236;806.4637016384097;806.681360862459;808.486611002015;809.0978558906835;811.7929927868386;811.9797005074861;812.569338250728;840.9537475438848;842.435568169328;842.5197637346715;842.7050532313672;842.7556008757452;652.4291245160484;811.4117264982899;838.2246422059601;839.8530257204965;841.0622156295686;604.5345084285076;609.2871340531589;609.387565496673;609.4454046817375;609.8475381154711;13383.933080334633;13384.93307533456;13400.798988015187;13410.396532156077;13416.798748018788;12515.374231288399;12941.352932353439;13000.414981325863;13129.409176587076;13224.517319000819;11706.297622142698;11743.236689615147;11792.41037948099;11889.405529723566;12057.879421205764;4105.117399759036;4131.256373852705;4133.338665813455;4135.193637240739;4145.91708165838;56878.43121568773;58061.709691451695;58196.99999999958;58215.708921455545;58267.417325826624;9889.505524723734;9975.401475911323;9987.750306242257;10073.345232559861;10196.235282353853;18123.36568220106;18139.365122220657;18159.909200453912;18220.45338639843;18225.08874556267;6761.763338283136;6767.9736933884515;6814.522983391115;6863.450923926074;7015.579065255999;3605.260921511084;3707.962920370816;3725.9627403725617;3731.589525152231;3745.382011968049;2698.7166347533225;2795.53873610856;2800.2439341377712;2800.2719292983566;2801.061644349166;435.2861307455775;497.9800807967713;502.1438447447094;512.853836656551;514.6783260462211;491.68532139430795;495.8016793282716;538.9272448219518;560.3220103674518;569.9373068962411;8618.328318221245;8655.394122411371;8749;8842.867356989651;9096.636134554676;541.8862038971781;557.3729554251468;557.5818136397702;563.2677519224991;568.1449418625026;3713.1830997180577;4000.9399859002137;4171.707980441401;4195.4336164618;4257.595528424795;58373.70813145907;78876;80986.78519822207;81834;93448.53275733713;48236;48532.5146748528;48935.26597101046;49191.50808491869;49801.25298120531;45479.317810232875;57359;69124.3087569128;72722.2727772726;73462.63268683622;8789.121087891159;8814.779630509289;8868.600912958804;8905.777355566162;9095.95452022762;38610.718088962756;39176.412353815285;43311;43462;45233.86915327011;42713.1457370857;44834.77582612066;61294.69352653208;61744;64739.768971954174;11497.655070347902;11710.414479275832;11811.704707382041;11877.703057423634;12010.399480026139;12986.870131298567;13245.337733113112;13586.252756098114;13590.388432520362;13960;12392.81410778857;12581;12925.15986460877;13151.802722959355;13178.406971686105;12066.215695979734;12068.215565988183;12339.9383003088;12363.93818030904;12884.291363974697;12185.207961482476;12384.195027323196;12523.74952500963;12770.61688149357;13056.477740890257;10074.949625251827;10325;10349.74125646865;10369;10575.312604680672;9981.15160211361;10561.570838706986;10584.523696433525;10591.788164236827;10593.311434756715 11:41:49 INFO - PROCESS | 25074 | __end_tp_report 11:41:49 INFO - PROCESS | 25074 | __start_cc_report 11:41:49 INFO - PROCESS | 25074 | _x_x_mozilla_cycle_collect,1060 11:41:49 INFO - PROCESS | 25074 | __end_cc_report 11:41:49 INFO - PROCESS | 25074 | __startTimestamp1468608109803__endTimestamp 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | ------- Summary: start ------- 11:41:49 INFO - PROCESS | 25074 | Number of tests: 6 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | [#0] dojo.html Cycles:165 Average:4677.64 Median:4806.81 stddev:526.27 (10.9%) stddev-sans-first:502.27 11:41:49 INFO - PROCESS | 25074 | Values: 2610.2 2619.0 2637.3 2660.1 2660.5 4591.0 4654.9 4687.8 4721.2 4738.9 4684.5 4733.2 4736.1 4760.2 4769.8 4335.4 4364.8 4423.0 4449.4 4501.3 4415.0 4434.9 4458.1 4466.6 4484.1 4117.9 4175.7 4248.7 4297.4 4302.6 4308.7 4312.9 4317.8 4347.7 4383.3 4366.9 4372.1 4383.8 4419.9 4432.5 4608.5 4628.6 4666.8 4740.8 4752.2 5076.8 5096.5 5119.6 5122.6 5129.0 5097.4 5142.6 5143.9 5155.1 5162.2 4608.7 4710.9 4764.7 4769.2 4833.3 5300.3 5320.9 5321.4 5328.1 5339.4 4787.7 5057.8 5058.7 5095.5 5105.2 4924.8 5044.1 5079.1 5084.7 5084.9 5034.4 5048.3 5063.4 5067.8 5120.0 4810.0 5024.7 5029.8 5031.3 5036.0 3900.3 3943.4 3946.8 3950.7 3965.8 3533.7 3565.2 3568.1 3605.7 3621.7 4367.0 4367.9 4368.7 4375.7 4408.4 4875.3 4887.8 5089.7 5098.5 5136.1 4311.4 4356.3 4365.0 4379.6 4382.6 4572.0 4574.2 4574.2 4608.8 4612.1 4640.9 4799.8 4801.1 4806.8 4808.4 5135.3 5169.6 5189.0 5191.9 5239.3 4854.1 4855.8 4859.4 4860.6 4902.1 4824.2 4910.0 4917.9 5136.1 5139.4 5002.3 5036.4 5037.2 5038.7 5079.4 4886.4 4892.1 4894.1 4895.0 4919.1 4720.3 4922.2 4996.1 5052.1 5066.9 4959.7 4971.9 4972.6 5017.1 5024.6 5029.6 5054.8 5054.9 5055.2 5097.9 4642.6 4695.8 4785.5 4853.7 4889.8 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | [#1] ext.html Cycles:180 Average:50192.98 Median:19477.38 stddev:92256.09 (473.7%) stddev-sans-first:92439.64 11:41:49 INFO - PROCESS | 25074 | Values: 563.4 577.5 579.2 587.8 590.9 29919.0 30437.8 41224.0 42496.0 42516.8 42718.8 42995.6 43001.8 43067.8 43133.6 7908.1 8056.2 8056.4 8057.9 8065.3 7565.5 10138.6 10408.6 10434.5 10752.9 10542.7 10546.7 10609.4 10626.9 10651.7 7650.5 10220.1 10382.2 10442.9 10460.8 10058.5 10420.4 10430.6 10431.5 10438.7 40110.4 40611.0 40611.4 40626.8 40670.4 3017.1 3071.4 3078.2 3094.5 3149.2 29810.9 30326.4 30373.7 30533.6 31449.4 3541.8 3562.1 3586.1 3592.1 3604.2 261965.0 262190.7 262746.0 262930.0 263234.0 55415.0 55857.4 56349.7 56368.7 56420.2 33940.5 34936.3 34993.7 36880.8 36887.0 14470.1 14560.9 14604.5 14647.8 14866.3 9494.9 10442.7 10700.3 11353.9 11391.7 19084.8 19109.0 19114.8 19141.0 19160.0 7036.6 7138.4 7164.2 7191.4 7300.8 772.4 873.3 898.8 902.0 976.1 27320.0 27387.3 28310.2 29401.4 30856.4 939.0 948.7 955.8 979.9 1050.2 14094.0 14555.0 14614.3 14778.6 14822.9 400297.0 401272.0 403912.0 404414.0 404694.0 50903.7 51200.2 51292.0 51349.5 51476.2 1084.0 1216.9 1229.7 1238.9 1263.9 27727.7 28836.1 28849.9 29125.0 29398.9 48048.5 49531.3 49542.0 54684.5 54752.0 364367.0 370694.0 370966.0 371139.0 372228.0 33556.5 34693.7 34759.7 34811.0 37326.0 33164.3 33229.7 41141.4 43699.0 43955.6 35413.0 37006.6 37221.3 37671.2 38250.4 37779.8 37954.0 37992.0 38260.4 38918.4 34325.0 35820.6 35861.6 35982.8 35985.5 31380.5 33716.7 33915.6 34026.0 34086.0 24675.4 25045.5 25046.6 25172.7 25445.0 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | [#2] jquery.html Cycles:180 Average:24792.34 Median:39035.81 stddev:63182.35 (161.9%) stddev-sans-first:63332.96 11:41:49 INFO - PROCESS | 25074 | Values: 358.8 367.3 373.7 382.6 396.5 16434.8 17698.7 18500.4 18717.4 18724.3 16330.0 17310.9 17774.2 17869.6 18221.2 5054.6 5250.6 5266.3 5273.4 5275.9 3799.0 3857.3 5137.9 6036.2 6166.6 6101.3 6105.8 6131.4 6135.6 6139.8 5896.3 6121.3 6127.4 6131.8 6137.2 3454.2 5053.6 5345.8 5350.4 5380.3 20567.9 21097.0 21098.9 21731.7 21836.7 2031.5 2106.5 2124.0 2151.8 2158.8 9272.8 9565.4 9839.4 10174.1 13907.9 1776.6 1793.9 1827.9 1828.6 1838.1 67979.7 73825.0 74857.6 75573.0 75819.6 10332.5 10560.9 10643.9 10689.2 10695.1 14609.6 14709.6 14725.5 14738.5 14749.6 7489.2 7775.6 7776.0 7874.0 7880.2 7213.8 7323.2 7362.0 7481.6 7500.7 4407.5 4491.8 4504.2 4601.0 4611.6 1865.5 1895.0 1896.2 1909.3 1980.9 796.6 840.6 841.6 865.1 917.6 16716.7 16837.7 17469.7 17531.0 18070.3 836.6 858.0 876.4 882.9 919.8 9360.3 9850.8 9877.6 9884.3 10028.6 375886.0 379654.0 380135.0 384235.0 385528.0 79260.0 80910.0 80967.2 81019.6 82047.2 828.9 871.8 884.4 886.1 899.3 15316.3 15637.6 15784.8 15800.0 16149.1 38412.6 38884.6 39187.0 39374.4 40389.6 53224.0 55498.7 56234.7 56438.2 56592.7 7641.0 7668.9 7707.7 8005.3 8011.6 11855.3 12051.2 12052.2 12187.3 12349.9 10206.2 10561.7 10702.0 10735.7 10807.8 10685.4 10771.2 10842.6 10927.3 11230.3 10446.1 10788.1 10792.5 10906.3 11112.7 7786.3 7876.3 7955.7 8097.3 8169.4 9726.6 10729.4 10757.6 10975.2 11034.0 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | [#3] mootools.html Cycles:180 Average:5162.11 Median:4586.58 stddev:2976.86 (64.9%) stddev-sans-first:2970.60 11:41:49 INFO - PROCESS | 25074 | Values: 1237.6 1391.5 1426.6 1498.4 1726.8 6850.4 7609.6 7929.3 7948.1 8204.3 7890.3 8095.6 8096.8 8102.6 8109.9 1852.1 1911.6 1915.6 2228.9 2260.8 1937.1 2140.7 2208.3 2211.1 2227.2 2045.5 2086.8 2094.4 2100.2 2100.7 1803.9 2112.1 2116.2 2117.1 2119.1 2100.2 2174.9 2175.7 2190.6 2191.1 7967.7 7987.2 8000.6 8015.1 8016.6 4433.6 4519.7 4523.4 4523.4 4527.4 2894.4 2899.6 2966.8 2981.2 2995.5 977.3 989.9 995.5 1014.4 1782.1 10633.6 11113.8 11117.5 11159.3 11183.4 3875.1 3996.8 4077.6 4078.2 4079.0 8664.7 8744.1 8747.1 8748.5 8757.8 4584.4 4588.7 4596.5 4597.4 4598.9 3665.6 3846.4 4259.9 4272.4 4279.1 3438.4 3540.2 3606.6 3608.0 3612.0 1014.8 1022.2 1026.6 1047.7 1052.4 603.4 625.2 652.5 656.7 751.7 5201.2 5285.3 5300.6 5301.9 5542.3 841.8 886.3 888.9 893.2 905.0 3344.6 3478.3 3529.6 3597.6 3601.3 9857.3 10102.1 10158.8 10249.9 10277.9 9999.7 10013.0 10031.9 10079.0 10130.4 7234.8 7257.8 7411.0 7446.7 7472.5 5151.8 5234.9 5267.6 5268.4 5275.0 8879.9 9040.6 9124.7 9132.4 9134.9 8873.2 9052.1 9260.4 9314.6 9315.1 6124.3 6669.9 6812.3 6825.9 6982.3 7432.3 7453.9 7458.0 7462.3 7508.1 6801.7 6805.6 6839.1 6937.8 6975.2 6774.1 6863.1 6866.5 6939.1 7052.0 6045.6 6176.0 6263.7 6282.4 6421.9 4412.6 4454.5 4475.8 4509.3 4522.8 4348.3 4434.4 4445.6 4534.1 4547.1 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | [#4] prototype.html Cycles:180 Average:4176.97 Median:4672.14 stddev:1229.15 (26.3%) stddev-sans-first:1197.47 11:41:49 INFO - PROCESS | 25074 | Values: 289.4 291.6 299.2 304.9 308.9 4801.3 4910.0 4912.4 4948.2 4958.7 4672.6 4845.3 4848.9 4859.9 4915.0 3855.9 3860.0 3862.2 3869.1 3875.1 3656.3 3744.4 3859.4 3881.5 3913.7 3758.7 3808.7 3811.7 3822.9 3827.0 3824.3 3830.7 3832.6 3836.0 3855.3 3390.7 3392.8 3402.7 3408.6 3423.9 4682.0 4795.6 4798.6 4835.5 4837.2 4361.5 4381.8 4383.6 4386.2 4404.6 5116.6 5117.2 5119.5 5134.5 5145.4 3417.3 3630.2 3633.4 3641.4 3706.0 5337.3 5381.9 5384.4 5385.0 5397.9 3728.7 3734.2 3751.9 3758.6 3767.9 3696.5 3787.2 3805.4 3811.7 3814.2 4273.1 4288.2 4297.4 4307.2 4324.1 4859.3 5055.4 5072.6 5088.3 5101.5 1245.9 1274.0 1280.8 1282.5 1286.6 804.9 823.7 836.3 837.2 842.7 4036.5 4045.4 4048.0 4050.0 4056.8 4648.8 4663.5 4671.6 4684.9 4686.8 3986.6 4005.2 4021.4 4024.1 4034.6 2335.3 2486.4 2492.8 2498.2 2507.6 4389.5 4414.4 4437.6 4459.7 4465.7 4704.7 4712.5 4719.5 4780.2 4796.0 4407.7 4465.9 4645.9 5044.8 5062.7 5352.2 5381.4 5382.2 5382.4 5396.0 5246.8 5259.2 5267.5 5271.6 5276.5 4937.5 4964.3 5017.5 5042.8 5044.4 3733.3 3747.3 3773.6 3781.8 3782.4 5124.7 5340.2 5379.5 5381.0 5410.7 5012.7 5122.6 5134.8 5159.6 5167.3 5121.5 5131.5 5145.0 5168.8 5173.3 4865.5 5055.5 5097.7 5103.1 5127.4 5124.9 5136.9 5152.6 5159.2 5170.4 5059.5 5060.9 5066.7 5071.2 5075.5 11:41:49 INFO - PROCESS | 25074 | 11:41:49 INFO - PROCESS | 25074 | [#5] yui.html Cycles:180 Average:15774.59 Median:21948.64 stddev:20265.81 (92.3%) stddev-sans-first:20290.79 11:41:49 INFO - PROCESS | 25074 | Values: 638.1 656.8 665.4 724.0 758.2 11960.4 12131.8 12733.5 12772.9 13304.2 13443.3 13500.5 13563.1 13615.6 13635.9 638.4 780.6 784.1 806.5 806.7 808.5 809.1 811.8 812.0 812.6 841.0 842.4 842.5 842.7 842.8 652.4 811.4 838.2 839.9 841.1 604.5 609.3 609.4 609.4 609.8 13383.9 13384.9 13400.8 13410.4 13416.8 12515.4 12941.4 13000.4 13129.4 13224.5 11706.3 11743.2 11792.4 11889.4 12057.9 4105.1 4131.3 4133.3 4135.2 4145.9 56878.4 58061.7 58197.0 58215.7 58267.4 9889.5 9975.4 9987.8 10073.3 10196.2 18123.4 18139.4 18159.9 18220.5 18225.1 6761.8 6768.0 6814.5 6863.5 7015.6 3605.3 3708.0 3726.0 3731.6 3745.4 2698.7 2795.5 2800.2 2800.3 2801.1 435.3 498.0 502.1 512.9 514.7 491.7 495.8 538.9 560.3 569.9 8618.3 8655.4 8749.0 8842.9 9096.6 541.9 557.4 557.6 563.3 568.1 3713.2 4000.9 4171.7 4195.4 4257.6 58373.7 78876.0 80986.8 81834.0 93448.5 48236.0 48532.5 48935.3 49191.5 49801.3 45479.3 57359.0 69124.3 72722.3 73462.6 8789.1 8814.8 8868.6 8905.8 9096.0 38610.7 39176.4 43311.0 43462.0 45233.9 42713.1 44834.8 61294.7 61744.0 64739.8 11497.7 11710.4 11811.7 11877.7 12010.4 12986.9 13245.3 13586.3 13590.4 13960.0 12392.8 12581.0 12925.2 13151.8 13178.4 12066.2 12068.2 12339.9 12363.9 12884.3 12185.2 12384.2 12523.7 12770.6 13056.5 10074.9 10325.0 10349.7 10369.0 10575.3 9981.2 10561.6 10584.5 10591.8 10593.3 11:41:49 INFO - PROCESS | 25074 | -------- Summary: end -------- 11:41:49 INFO - PROCESS | 25074 | 11:41:50 INFO - TEST-INFO | 25074: exit 0 11:41:50 INFO - TEST-OK | dromaeo_css | took 1120002ms 11:41:50 INFO - TEST-START | kraken 11:41:50 INFO - operating with platform_type : linux_ 11:41:50 INFO - Initialising browser for kraken test... 11:41:50 INFO - TEST-INFO | started process 25259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf2wQQ9/profile http://localhost:39953/getInfo.html) 11:41:55 INFO - PROCESS | 25259 | __metrics Screen width/height:1600/1200 11:41:55 INFO - PROCESS | 25259 | colorDepth:24 11:41:55 INFO - PROCESS | 25259 | Browser inner width/height: 1024/697 11:41:55 INFO - PROCESS | 25259 | __metrics 11:41:55 INFO - PROCESS | 25259 | 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" 11:41:55 INFO - PROCESS | 25259 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:56 INFO - TEST-INFO | 25259: exit 0 11:41:56 INFO - Browser initialized. 11:41:56 INFO - Running cycle 1/1 for kraken test... 11:41:56 INFO - TEST-INFO | started process 25345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf2wQQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:08 INFO - PROCESS | 25345 | RSS: Main: 158633984 11:42:08 INFO - PROCESS | 25345 | 11:42:11 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39953/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:12 INFO - PROCESS | 25345 | RSS: Main: 217452544 11:42:12 INFO - PROCESS | 25345 | 11:42:15 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39953/tests/kraken/driver.html?testName=audio-dft) 11:42:15 INFO - PROCESS | 25345 | RSS: Main: 204451840 11:42:15 INFO - PROCESS | 25345 | 11:42:19 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39953/tests/kraken/driver.html?testName=audio-fft) 11:42:19 INFO - PROCESS | 25345 | RSS: Main: 270446592 11:42:19 INFO - PROCESS | 25345 | 11:42:21 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39953/tests/kraken/driver.html?testName=audio-oscillator) 11:42:22 INFO - PROCESS | 25345 | RSS: Main: 181489664 11:42:22 INFO - PROCESS | 25345 | 11:42:24 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:25 INFO - PROCESS | 25345 | RSS: Main: 185733120 11:42:25 INFO - PROCESS | 25345 | 11:42:28 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39953/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:29 INFO - PROCESS | 25345 | RSS: Main: 222461952 11:42:29 INFO - PROCESS | 25345 | 11:42:32 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39953/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:33 INFO - PROCESS | 25345 | RSS: Main: 222814208 11:42:33 INFO - PROCESS | 25345 | 11:42:35 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39953/tests/kraken/driver.html?testName=json-parse-financial) 11:42:36 INFO - PROCESS | 25345 | RSS: Main: 222810112 11:42:36 INFO - PROCESS | 25345 | 11:42:38 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:38 INFO - PROCESS | 25345 | RSS: Main: 210186240 11:42:38 INFO - PROCESS | 25345 | 11:42:40 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:41 INFO - PROCESS | 25345 | RSS: Main: 214798336 11:42:41 INFO - PROCESS | 25345 | 11:42:43 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:44 INFO - PROCESS | 25345 | RSS: Main: 215310336 11:42:44 INFO - PROCESS | 25345 | 11:42:47 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:47 INFO - PROCESS | 25345 | RSS: Main: 231772160 11:42:47 INFO - PROCESS | 25345 | 11:42:50 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:51 INFO - PROCESS | 25345 | RSS: Main: 227254272 11:42:51 INFO - PROCESS | 25345 | 11:42:52 INFO - PROCESS | 25345 | Cycle 1(1): loaded http://localhost:39953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39953/tests/kraken/driver.html?testName=ai-astar) 11:42:53 INFO - PROCESS | 25345 | RSS: Main: 269737984 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | __start_tp_report 11:42:53 INFO - PROCESS | 25345 | _x_x_mozilla_page_load 11:42:53 INFO - PROCESS | 25345 | _x_x_mozilla_page_load_details 11:42:53 INFO - PROCESS | 25345 | |i|pagename|runs| 11:42:53 INFO - PROCESS | 25345 | |0;ai-astar;106;115;114;115;114;114;114;114;113;114 11:42:53 INFO - PROCESS | 25345 | |1;audio-beat-detection;147;121;122;183;123;123;150;132;173;129 11:42:53 INFO - PROCESS | 25345 | |2;audio-dft;161;163;161;162;163;161;162;162;163;163 11:42:53 INFO - PROCESS | 25345 | |3;audio-fft;75;76;76;108;77;77;76;75;111;75 11:42:53 INFO - PROCESS | 25345 | |4;audio-oscillator;85;85;121;86;86;87;114;85;85;127 11:42:53 INFO - PROCESS | 25345 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;116 11:42:53 INFO - PROCESS | 25345 | |6;imaging-darkroom;146;145;147;146;146;147;146;146;146;146 11:42:53 INFO - PROCESS | 25345 | |7;imaging-desaturate;95;95;94;95;95;95;95;94;95;94 11:42:53 INFO - PROCESS | 25345 | |8;json-parse-financial;66;64;64;65;65;65;64;65;66;64 11:42:53 INFO - PROCESS | 25345 | |9;json-stringify-tinderbox;66;66;66;66;66;65;66;66;66;65 11:42:53 INFO - PROCESS | 25345 | |10;stanford-crypto-aes;88;88;79;87;85;78;81;78;79;90 11:42:53 INFO - PROCESS | 25345 | |11;stanford-crypto-ccm;128;126;133;130;125;129;141;127;191;129 11:42:53 INFO - PROCESS | 25345 | |12;stanford-crypto-pbkdf2;162;168;166;169;164;163;162;166;166;161 11:42:53 INFO - PROCESS | 25345 | |13;stanford-crypto-sha256-iterative;66;65;66;66;66;65;66;65;64;65 11:42:53 INFO - PROCESS | 25345 | __end_tp_report 11:42:53 INFO - PROCESS | 25345 | __start_cc_report 11:42:53 INFO - PROCESS | 25345 | _x_x_mozilla_cycle_collect,1910 11:42:53 INFO - PROCESS | 25345 | __end_cc_report 11:42:53 INFO - PROCESS | 25345 | __startTimestamp1468608173077__endTimestamp 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | ------- Summary: start ------- 11:42:53 INFO - PROCESS | 25345 | Number of tests: 14 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.63 (2.3%) stddev-sans-first:0.60 11:42:53 INFO - PROCESS | 25345 | Values: 106.0 115.0 114.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:139.50 stddev:22.45 (16.1%) stddev-sans-first:23.68 11:42:53 INFO - PROCESS | 25345 | Values: 147.0 121.0 122.0 183.0 123.0 123.0 150.0 132.0 173.0 129.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:0.88 (0.5%) stddev-sans-first:0.83 11:42:53 INFO - PROCESS | 25345 | Values: 161.0 163.0 161.0 162.0 163.0 161.0 162.0 162.0 163.0 163.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:14.21 (18.7%) stddev-sans-first:14.81 11:42:53 INFO - PROCESS | 25345 | Values: 75.0 76.0 76.0 108.0 77.0 77.0 76.0 75.0 111.0 75.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:17.24 (20.3%) stddev-sans-first:17.81 11:42:53 INFO - PROCESS | 25345 | Values: 85.0 85.0 121.0 86.0 86.0 87.0 114.0 85.0 85.0 127.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:42:53 INFO - PROCESS | 25345 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:42:53 INFO - PROCESS | 25345 | Values: 146.0 145.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:42:53 INFO - PROCESS | 25345 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 11:42:53 INFO - PROCESS | 25345 | Values: 66.0 64.0 64.0 65.0 65.0 65.0 64.0 65.0 66.0 64.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 11:42:53 INFO - PROCESS | 25345 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 65.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:86.00 stddev:4.76 (5.5%) stddev-sans-first:4.74 11:42:53 INFO - PROCESS | 25345 | Values: 88.0 88.0 79.0 87.0 85.0 78.0 81.0 78.0 79.0 90.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:129.50 stddev:19.89 (15.4%) stddev-sans-first:20.89 11:42:53 INFO - PROCESS | 25345 | Values: 128.0 126.0 133.0 130.0 125.0 129.0 141.0 127.0 191.0 129.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:166.00 stddev:2.71 (1.6%) stddev-sans-first:2.69 11:42:53 INFO - PROCESS | 25345 | Values: 162.0 168.0 166.0 169.0 164.0 163.0 162.0 166.0 166.0 161.0 11:42:53 INFO - PROCESS | 25345 | 11:42:53 INFO - PROCESS | 25345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 11:42:53 INFO - PROCESS | 25345 | Values: 66.0 65.0 66.0 66.0 66.0 65.0 66.0 65.0 64.0 65.0 11:42:53 INFO - PROCESS | 25345 | -------- Summary: end -------- 11:42:53 INFO - PROCESS | 25345 | 11:42:54 INFO - TEST-INFO | 25345: exit 0 11:42:54 INFO - TEST-OK | kraken | took 63516ms 11:42:54 INFO - SUITE-END | took 1183s 11:42:54 INFO - Completed test suite (00:19:43) 11:42:54 INFO - javascript benchmark 11:42:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.2038878142166, 2619.017868299388, 2637.2879322582908, 2660.135455976808, 2660.4812061647976, 4591.0, 4654.930176047362, 4687.765611719413, 4721.244600863863, 4738.881527961798, 4684.508126646704, 4733.195356789345, 4736.100140973213, 4760.166970780108, 4769.761511924407, 4335.436393268887, 4364.803583838735, 4423.0, 4449.42157519522, 4501.3022981437925, 4414.955850441503, 4434.933475997863, 4458.108378324348, 4466.62033727132, 4484.058347746977, 4117.91764164718, 4175.665946724254, 4248.702590818644, 4297.35539669049, 4302.634276086536, 4308.67684923632, 4312.935305970413, 4317.784110794448, 4347.673924455678, 4383.320585309282, 4366.8908277293, 4372.125574885035, 4383.75889326087, 4419.9337009944875, 4432.53458386868, 4608.493065762764, 4628.583427491509, 4666.813327466897, 4740.762961851928, 4752.215884379108, 5076.847694569132, 5096.490350964911, 5119.56483698886, 5122.641415100945, 5128.974355128238, 5097.362829646294, 5142.588592912558, 5143.897122057575, 5155.149400348938, 5162.22566615007, 4608.677392582521, 4710.858674239778, 4764.690295130806, 4769.189237829577, 4833.299171620095, 5300.337457817773, 5320.893582128413, 5321.36143662763, 5328.0675881720545, 5339.385970613352, 4787.664863459524, 5057.8229761958155, 5058.696478211319, 5095.464976177522, 5105.15764898795, 4924.8276310328965, 5044.066847633199, 5079.060373830853, 5084.669496482717, 5084.898302033938, 5034.446210916796, 5048.3184770056305, 5063.443021267658, 5067.822626208065, 5120.0, 4809.975950120227, 5024.748762561857, 5029.823956161516, 5031.345925029723, 5036.0, 3900.2979463696806, 3943.428202910562, 3946.7631942082994, 3950.6839452843706, 3965.8215380307956, 3533.6819686228364, 3565.2156525564333, 3568.072301201654, 3605.7295702822394, 3621.7102631789394, 4367.039251364695, 4367.868963931087, 4368.672349573794, 4375.7374557526655, 4408.448943882015, 4875.268709693503, 4887.755612219375, 5089.720065396439, 5098.490150984871, 5136.101182293084, 4311.396404503372, 4356.259435895905, 4364.978175109104, 4379.64962802975, 4382.561743825592, 4571.954280457219, 4574.199515084847, 4574.222382195035, 4608.838690645811, 4612.123696497655, 4640.883977900579, 4799.808007679723, 4801.063792560557, 4806.807727690853, 4808.447028591757, 5135.306733591066, 5169.586433085419, 5189.0, 5191.92212116811, 5239.345081864767, 4854.053459575349, 4855.757212139309, 4859.416869975626, 4860.562549370574, 4902.093112774148, 4824.155772739827, 4910.0, 4917.85246442593, 5136.101182293159, 5139.408967968731, 5002.324686167321, 5036.370453693288, 5037.19404895215, 5038.697678139323, 5079.415867175322, 4886.3647725796845, 4892.143874821963, 4894.143524883202, 4895.0, 4919.065377578248, 4720.291956206596, 4922.1632322505975, 4996.125678006407, 5052.090623687772, 5066.949330506648, 4959.70241785494, 4971.925421118758, 4972.577330926912, 5017.147084995487, 5024.598032157492, 5029.572486338702, 5054.7978080876355, 5054.873628159326, 5055.216441451581, 5097.898042039213, 4642.558956899089, 4695.812167513262, 4785.5453731896805, 4853.733044682576, 4889.828855990166], "value": 4642.1791625408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.4140493886358, 577.4773829684135, 579.1775678536478, 587.7590188022912, 590.9143174239734, 29919.0, 30437.847810760944, 41223.96940076496, 42496.0, 42516.78741606295, 42718.78640606793, 42995.57004429955, 43001.78499107508, 43067.78466107673, 43133.568664313345, 7908.130105688384, 8056.234657707509, 8056.436049476539, 8057.919420805775, 8065.2741253287195, 7565.508241964282, 10138.59445622178, 10408.63569775058, 10434.530446129942, 10752.946235268852, 10542.683719488428, 10546.736331591695, 10609.363438193694, 10626.893731062668, 10651.733706657356, 7650.464467487278, 10220.131288840457, 10382.221333399988, 10442.895571044344, 10460.79078418435, 10058.497075146286, 10420.384840349758, 10430.634927777492, 10431.530581123867, 10438.739031524197, 40110.39834402486, 40611.0, 40611.390829137585, 40626.79686601578, 40670.38994415086, 3017.09487153853, 3071.4317851197375, 3078.1535077853546, 3094.4739394302796, 3149.228439032429, 29810.850945745133, 30326.393472130432, 30373.696263037527, 30533.610533610357, 31449.37101257985, 3541.769784963969, 3562.1450851795644, 3586.085548185196, 3592.1378869071496, 3604.1710406606367, 261965.0, 262190.68904655543, 262746.0, 262930.0, 263234.0, 55415.0, 55857.44142558604, 56349.71825140848, 56368.71815640978, 56420.153697694564, 33940.49089263663, 34936.30127397438, 34993.65006349955, 36880.81559592239, 36887.0, 14470.131792092297, 14560.854391456161, 14604.488842890449, 14647.780283295759, 14866.331015104346, 9494.905050949541, 10442.738931526772, 10700.30448020876, 11353.886461135284, 11391.658250252505, 19084.80915190858, 19109.0, 19114.80885191158, 19141.0, 19160.0, 7036.6481675916, 7138.39323657495, 7164.176119746296, 7191.388731957738, 7300.780976570712, 772.4168252968973, 873.2664561768145, 898.7618281155499, 901.977450563728, 976.0971101731012, 27320.0, 27387.315317116834, 28310.15069547876, 29401.411971760444, 30856.382872342427, 939.0281059103932, 948.6869333120054, 955.7945041816043, 979.9314048016713, 1050.1913526584487, 14094.0, 14554.981151319518, 14614.269286535631, 14778.63053423673, 14822.851771482363, 400297.0, 401272.0, 403912.0, 404414.0, 404694.0, 50903.745481273094, 51200.23199652008, 51292.0, 51349.48650513447, 51476.22785658218, 1083.9620613278498, 1216.92698438094, 1229.6679896427736, 1238.9008879289636, 1263.9304838233802, 27727.72272277332, 28836.134915952556, 28849.85575072111, 29125.0, 29398.853005734836, 48048.519514805805, 49531.25703114384, 49542.0, 54684.453155467934, 54752.0, 364367.0, 370694.0, 370966.0, 371139.0, 372228.0, 33556.49665255072, 34693.65524207532, 34759.652403476655, 34811.0, 37326.0, 33164.33671326608, 33229.66770332266, 41141.382879256234, 43699.0, 43955.560444395145, 35413.0, 37006.629933700315, 37221.25557488781, 37671.24657506889, 38250.42624360581, 37779.81110094432, 37954.0, 37992.0, 38260.42609360806, 38918.4162237561, 34325.0, 35820.64179358173, 35861.64138358583, 35982.8200858994, 35985.460218096225, 31380.529292060182, 33716.66283337135, 33915.64337426475, 34026.0, 34086.0, 24675.383115422257, 25045.49909001846, 25046.62430063514, 25172.72364217238, 25445.0], "value": 18405.251360395196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.8026585378043, 367.3186239525678, 373.73651575639167, 382.5562347676695, 396.5261512492572, 16434.753478697814, 17698.734518982208, 18500.352487662934, 18717.438476845684, 18724.344647937323, 16330.0, 17310.88404087267, 17774.200160992754, 17869.64260714785, 18221.180046897887, 5054.646174767759, 5250.579953603722, 5266.3153790007245, 5273.393559740641, 5275.947240527584, 3798.9620103798884, 3857.32496813058, 5137.922931156036, 6036.245469316335, 6166.568340216187, 6101.2983506896835, 6105.786297479589, 6131.356207598183, 6135.631862088267, 6139.754409823602, 5896.321922978848, 6121.296050954131, 6127.448529632355, 6131.785387511438, 6137.202163718688, 3454.2055327274866, 5053.570446512051, 5345.812896548641, 5350.35795704514, 5380.273663055476, 20567.8971605141, 21097.0, 21098.89450552753, 21731.67402488964, 21836.672449913265, 2031.5124370151204, 2106.5470923751313, 2123.9787602123934, 2151.7848215178515, 2158.7949144831373, 9272.814543709155, 9565.426074435487, 9839.409635421898, 10174.084332410044, 13907.860921390758, 1776.635789663116, 1793.9192736326897, 1827.9268829246814, 1828.570285982793, 1838.1452624529659, 67979.66010169967, 73825.0, 74857.62571187163, 75573.0, 75819.62090189513, 10332.483375831178, 10560.894391056145, 10643.94678026605, 10689.198310126772, 10695.144388448905, 14609.634759131106, 14709.632259193606, 14725.484608038882, 14738.484153054591, 14749.631259218606, 7489.176190619028, 7775.611219439005, 7775.961120194363, 7873.960630196812, 7880.211978802188, 7213.783586492414, 7323.157836848724, 7362.042934418491, 7481.5511069334925, 7500.662470188855, 4407.471103467605, 4491.797869095899, 4504.211762941472, 4600.953990460052, 4611.608013318905, 1865.5242913057084, 1894.9621007579772, 1896.1751638037497, 1909.2649330008046, 1980.920763169486, 796.6096612659755, 840.6175190288404, 841.5960339037297, 865.1348651348651, 917.6467060181744, 16716.665666686597, 16837.663246734995, 17469.7379539307, 17531.0, 18070.277188912558, 836.6402446947749, 857.9656813727506, 876.3646356391565, 882.911708829112, 919.7516670499061, 9360.251179905592, 9850.802983940424, 9877.604895804086, 9884.258680598983, 10028.648997285205, 375886.0, 379654.0, 380135.0, 384235.0, 385528.0, 79260.0, 80910.0, 80967.19032809715, 81019.59490202629, 82047.17952820395, 828.8549503836925, 871.8038441350645, 884.3720958119807, 886.0829041941688, 899.25361949583, 15316.310766015778, 15637.609059773597, 15784.76322855181, 15800.0, 16149.111798851176, 38412.61587384091, 38884.61115388923, 39187.0, 39374.40938385869, 40389.59610403976, 53224.0, 55498.72250638721, 56234.71882640561, 56438.1534276978, 56592.71703641456, 7640.961795190989, 7668.884966725392, 7707.653155607899, 8005.279524842792, 8011.559364235023, 11855.288682679067, 12051.216670916363, 12052.216605920587, 12187.329696866758, 12349.93825030869, 10206.183505319408, 10561.683149505527, 10702.0, 10735.733485216495, 10807.837882431613, 10685.412302323446, 10771.246012779344, 10842.620508282173, 10927.344359338465, 11230.3261804292, 10446.112080472942, 10788.083012943987, 10792.460376981277, 10906.34561926287, 11112.722181945515, 7786.287016856509, 7876.251756083163, 7955.681772729026, 8097.311728503143, 8169.428140030141, 9726.610935562498, 10729.356238625707, 10757.623483178051, 10975.231733778879, 11034.0], "value": 8529.200974894478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.5544803870612, 1391.5477469822308, 1426.6290764401253, 1498.415617909015, 1726.775519182507, 6850.417714494268, 7609.581473018981, 7929.286364227226, 7948.085970113439, 8204.3436525078, 7890.250426209515, 8095.5952202389935, 8096.838063238746, 8102.594870256478, 8109.91890081099, 1852.0739630184908, 1911.5985643014983, 1915.6073005034004, 2228.921987730434, 2260.8304377171694, 1937.118611031984, 2140.7110040144617, 2208.293346129239, 2211.060299372768, 2227.231605096239, 2045.4681782736448, 2086.791320867916, 2094.4030951178916, 2100.2229175205193, 2100.69539916712, 1803.8556915446864, 2112.1234687604624, 2116.2381542644634, 2117.1108134583433, 2119.109973811003, 2100.1809294375053, 2174.92387766429, 2175.7280339957506, 2190.5618876224657, 2191.123550579765, 7967.721129760431, 7987.201279872024, 8000.599970001476, 8015.078265999368, 8016.559089250089, 4433.556644335573, 4519.661025423074, 4523.411956445641, 4523.434570678665, 4527.4114365132655, 2894.3921776426764, 2899.594056832045, 2966.7626589872757, 2981.195077329109, 2995.5207166853415, 977.2816979520047, 989.9257555683281, 995.4873240281261, 1014.3660212367271, 1782.1445706061163, 10633.627823026234, 11113.777724445466, 11117.499712512956, 11159.274647147991, 11183.440827958651, 3875.1280961783937, 3996.760194388346, 4077.6330130287824, 4078.204750073707, 4078.979605102015, 8664.740057798275, 8744.081871403538, 8747.081556436482, 8748.475091494403, 8757.824843503095, 4584.4498660161, 4588.701734387254, 4596.49438561758, 4597.44830620321, 4598.88502787433, 3665.6151104133683, 3846.3845784674318, 4259.914801704011, 4272.359146128106, 4279.101388708344, 3438.415469370163, 3540.2034542227793, 3606.585242697071, 3607.981960090183, 3612.0428086557085, 1014.7919676466307, 1022.2231104360591, 1026.5637104230673, 1047.6909311753052, 1052.3896140238644, 603.432773193197, 625.1778910732372, 652.4845372156038, 656.7241758461457, 751.6617522115071, 5201.1678131498775, 5285.339332583427, 5300.575953923677, 5301.946980530222, 5542.334919809648, 841.8358420108143, 886.3352485635774, 888.8977767556813, 893.1515060692238, 905.0496978173023, 3344.5819272590925, 3478.339115568034, 3529.5588051493564, 3597.5862775780597, 3601.2797440511476, 9857.260705447121, 10102.09081182697, 10158.796824063478, 10249.897501024894, 10277.9486102569, 9999.700008999742, 10013.048760367754, 10031.949840250898, 10079.042490963348, 10130.392176469435, 7234.819129521804, 7257.818554536178, 7410.962945185347, 7446.66490007951, 7472.476926615193, 5151.8196863109615, 5234.947650523446, 5267.578593712417, 5268.394134674561, 5275.0, 8879.866801997847, 9040.593173307085, 9124.680636177702, 9132.406393584395, 9134.908650913405, 8873.245774109273, 9052.094790521158, 9260.351775375659, 9314.627414903329, 9315.068493150631, 6124.326324104256, 6669.866602668017, 6812.284710105368, 6825.863482730417, 6982.33667801558, 7432.293932076444, 7453.888191677238, 7458.0, 7462.328390444886, 7508.061492313461, 6801.693923773343, 6805.557638753465, 6839.1451068616425, 6937.791866244021, 6975.162980442379, 6774.085498457645, 6863.07348507965, 6866.485013623898, 6939.063226464363, 7052.0, 6045.576809623284, 6176.0, 6263.655498947602, 6282.403171698681, 6421.93578064232, 4412.646988240997, 4454.4877339106415, 4475.753833539186, 4509.278515437514, 4522.796474158737, 4348.282533382083, 4434.357018232274, 4445.599896009375, 4534.115847409724, 4547.1133129040845], "value": 4109.501299787583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.41104851626943, 291.6150681100947, 299.1548874429735, 304.9252933031408, 308.8563817824711, 4801.327814106028, 4909.950900490994, 4912.38595175603, 4948.233023881299, 4958.702477851331, 4672.64955128365, 4845.3216549683075, 4848.854534363974, 4859.854204373865, 4914.97542512287, 3855.9421608675893, 3859.9807000964956, 3862.246861861938, 3869.1487872667967, 3875.147467557133, 3656.341858465475, 3744.3821769408014, 3859.4210868369687, 3881.5342158940966, 3913.7456065355805, 3758.6617204451595, 3808.7143464240294, 3811.7331786774935, 3822.8853134406013, 3826.9808650956707, 3824.3116239076953, 3830.712696547756, 3832.5975772543898, 3836.0218144373284, 3855.325318069327, 3390.7117894978956, 3392.8133952632597, 3402.7447941404494, 3408.5739282589675, 3423.880164194266, 4682.016776476944, 4795.568398844121, 4798.640101992364, 4835.468098509196, 4837.177679794443, 4361.520232774392, 4381.824727010916, 4383.561643835623, 4386.166628340605, 4404.559544045602, 5116.565091967187, 5117.1556693145585, 5119.462456442095, 5134.512221338967, 5145.408278048035, 3417.265287963075, 3630.2393339230453, 3633.418653015531, 3641.3809652359164, 3705.981470092659, 5337.332833395825, 5381.892362152774, 5384.40771515133, 5385.0, 5397.946020539823, 3728.6949567651645, 3734.1598140418187, 3751.8744376686886, 3758.567764707039, 3767.9058023549082, 3696.5194524711615, 3787.242551489713, 3805.448210009533, 3811.676007539335, 3814.1608846053823, 4273.145370925828, 4288.2495563276925, 4297.419848320436, 4307.246231909403, 4324.113556720865, 4859.271109333628, 5055.418626857885, 5072.644914855999, 5088.262201980692, 5101.540861322499, 1245.9190152640049, 1273.9745205095846, 1280.8334916460988, 1282.5062350994933, 1286.5754301080622, 804.9315808156372, 823.6581818545357, 836.3225787112458, 837.1712005114892, 842.6797816829566, 4036.5156181258435, 4045.37296719009, 4047.98800299925, 4049.959500405017, 4056.7565946043333, 4648.790804413809, 4663.510331415153, 4671.6262698984, 4684.882877928011, 4686.7656617169005, 3986.621270979252, 4005.1589166275407, 4021.416894550274, 4024.1146947671464, 4034.636882680514, 2335.3344296875307, 2486.365976675936, 2492.7660807900206, 2498.1880888711244, 2507.6489291499206, 4389.4513185851765, 4414.359917811899, 4437.556244375602, 4459.710118842329, 4465.732056076646, 4704.670673052922, 4712.458067322302, 4719.504452032487, 4780.163471392492, 4795.968866693677, 4407.713498622579, 4465.866024019285, 4645.861763867874, 5044.764032811838, 5062.7468626568525, 5352.197170424468, 5381.35868560093, 5382.246485491956, 5382.381026182039, 5396.0, 5246.816361427332, 5259.15853463444, 5267.473252674702, 5271.578273738015, 5276.5251127398715, 4937.46938449082, 4964.280179373898, 5017.54842064216, 5042.798288068583, 5044.394672639307, 3733.272011957642, 3747.3254814133716, 3773.566039905446, 3781.829817658267, 3782.3759079752635, 5124.743762811919, 5340.225667278145, 5379.488948549882, 5380.973095134499, 5410.729463526886, 5012.749362531786, 5122.615803814654, 5134.845954621367, 5159.613029022763, 5167.302414174038, 5121.513456221653, 5131.512506311894, 5145.0, 5168.8449346519665, 5173.275741396133, 4865.513448655106, 5055.545000949932, 5097.745112744422, 5103.081445339874, 5127.359080114986, 5124.897502050013, 5136.922946155736, 5152.639315247897, 5159.226116082467, 5170.371333030083, 5059.544640982329, 5060.924086138784, 5066.707989462663, 5071.18860982241, 5075.467075956972], "value": 3784.620423795191, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.0907207229696, 656.7602824968887, 665.3612531969309, 723.9746608868691, 758.1925249609168, 11960.401979901002, 12131.818022729643, 12733.490660373585, 12772.872271277285, 13304.201747895133, 13443.32783360833, 13500.527481538149, 13563.050586458952, 13615.591532254024, 13635.863641363583, 638.3712043637014, 780.5667854340838, 784.0669603172236, 806.4637016384097, 806.681360862459, 808.486611002015, 809.0978558906835, 811.7929927868386, 811.9797005074861, 812.569338250728, 840.9537475438848, 842.435568169328, 842.5197637346715, 842.7050532313672, 842.7556008757452, 652.4291245160484, 811.4117264982899, 838.2246422059601, 839.8530257204965, 841.0622156295686, 604.5345084285076, 609.2871340531589, 609.387565496673, 609.4454046817375, 609.8475381154711, 13383.933080334633, 13384.93307533456, 13400.798988015187, 13410.396532156077, 13416.798748018788, 12515.374231288399, 12941.352932353439, 13000.414981325863, 13129.409176587076, 13224.517319000819, 11706.297622142698, 11743.236689615147, 11792.41037948099, 11889.405529723566, 12057.879421205764, 4105.117399759036, 4131.256373852705, 4133.338665813455, 4135.193637240739, 4145.91708165838, 56878.43121568773, 58061.709691451695, 58196.99999999958, 58215.708921455545, 58267.417325826624, 9889.505524723734, 9975.401475911323, 9987.750306242257, 10073.345232559861, 10196.235282353853, 18123.36568220106, 18139.365122220657, 18159.909200453912, 18220.45338639843, 18225.08874556267, 6761.763338283136, 6767.9736933884515, 6814.522983391115, 6863.450923926074, 7015.579065255999, 3605.260921511084, 3707.962920370816, 3725.9627403725617, 3731.589525152231, 3745.382011968049, 2698.7166347533225, 2795.53873610856, 2800.2439341377712, 2800.2719292983566, 2801.061644349166, 435.2861307455775, 497.9800807967713, 502.1438447447094, 512.853836656551, 514.6783260462211, 491.68532139430795, 495.8016793282716, 538.9272448219518, 560.3220103674518, 569.9373068962411, 8618.328318221245, 8655.394122411371, 8749.0, 8842.867356989651, 9096.636134554676, 541.8862038971781, 557.3729554251468, 557.5818136397702, 563.2677519224991, 568.1449418625026, 3713.1830997180577, 4000.9399859002137, 4171.707980441401, 4195.4336164618, 4257.595528424795, 58373.70813145907, 78876.0, 80986.78519822207, 81834.0, 93448.53275733713, 48236.0, 48532.5146748528, 48935.26597101046, 49191.50808491869, 49801.25298120531, 45479.317810232875, 57359.0, 69124.3087569128, 72722.2727772726, 73462.63268683622, 8789.121087891159, 8814.779630509289, 8868.600912958804, 8905.777355566162, 9095.95452022762, 38610.718088962756, 39176.412353815285, 43311.0, 43462.0, 45233.86915327011, 42713.1457370857, 44834.77582612066, 61294.69352653208, 61744.0, 64739.768971954174, 11497.655070347902, 11710.414479275832, 11811.704707382041, 11877.703057423634, 12010.399480026139, 12986.870131298567, 13245.337733113112, 13586.252756098114, 13590.388432520362, 13960.0, 12392.81410778857, 12581.0, 12925.15986460877, 13151.802722959355, 13178.406971686105, 12066.215695979734, 12068.215565988183, 12339.9383003088, 12363.93818030904, 12884.291363974697, 12185.207961482476, 12384.195027323196, 12523.74952500963, 12770.61688149357, 13056.477740890257, 10074.949625251827, 10325.0, 10349.74125646865, 10369.0, 10575.312604680672, 9981.15160211361, 10561.570838706986, 10584.523696433525, 10591.788164236827, 10593.311434756715], "value": 6486.2418410790815, "unit": "score"}], "name": "dromaeo_css", "value": 6472.49275610574, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 122.0, 183.0, 123.0, 123.0, 150.0, 132.0, 173.0, 129.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 162.0, 163.0, 161.0, 162.0, 162.0, 163.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 108.0, 77.0, 77.0, 76.0, 75.0, 111.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 121.0, 86.0, 86.0, 87.0, 114.0, 85.0, 85.0, 127.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 79.0, 87.0, 85.0, 78.0, 81.0, 78.0, 79.0, 90.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 133.0, 130.0, 125.0, 129.0, 141.0, 127.0, 191.0, 129.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 166.0, 169.0, 164.0, 163.0, 162.0, 166.0, 166.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1531.9000000000003, "alertThreshold": 2.0}]} 11:42:54 INFO - Return code: 0 11:42:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:54 INFO - # TBPL SUCCESS # 11:42:54 INFO - Running post-action listener: _resource_record_post_action 11:42:54 INFO - ##### 11:42:54 INFO - ##### Finished run-tests step (success) 11:42:54 INFO - ##### 11:42:54 INFO - Running post-run listener: _resource_record_post_run 11:42:54 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540127232; Read time: 8; Write time: 725940 11:42:54 INFO - TinderboxPrint: CPU usage
13.0% 11:42:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:42:54 INFO - TinderboxPrint: I/O write bytes / time
540,127,232 / 725,940 11:42:54 INFO - TinderboxPrint: CPU idle
8,330.6 (87.0%) 11:42:54 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 11:42:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246792192; Read time: 0; Write time: 371664 11:42:54 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289439744; Read time: 8; Write time: 353812 11:42:55 INFO - Running post-run listener: _upload_blobber_files 11:42:55 INFO - Blob upload gear active. 11:42:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:55 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 11:42:55 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'] 11:42:55 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 11:42:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:56 INFO - (blobuploader) - INFO - Done attempting. 11:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:01 INFO - (blobuploader) - INFO - Done attempting. 11:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:43:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:02 INFO - (blobuploader) - INFO - Done attempting. 11:43:02 INFO - (blobuploader) - INFO - Iteration through files over. 11:43:02 INFO - Return code: 0 11:43:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:43:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:43:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c727fb38240200cbc9b1746d070c29c8a8d11c7e9d03662cf8a0d42e5d9250f150980bcf4dac05348b8171058a096268535a27d4f3846b2bb86d90d26b20245c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5f24c3eb3ee3e9813a24b3db58917196be9bacc55ed01119326cac363c0061eef226843d95b9b089b7f871bd7b30e83a8945e0491115baaead92498e4dcb7a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a58e72ee5e3631a789abfa20f64724af8e3ac328b29f45e443c929ac0dba01fab45956c102e9a9be61ef8a117f2946edba043e2b486d8e77eede05d7b0d5e7ac"} 11:43:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:43:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:43:02 INFO - Contents: 11:43:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c727fb38240200cbc9b1746d070c29c8a8d11c7e9d03662cf8a0d42e5d9250f150980bcf4dac05348b8171058a096268535a27d4f3846b2bb86d90d26b20245c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5f24c3eb3ee3e9813a24b3db58917196be9bacc55ed01119326cac363c0061eef226843d95b9b089b7f871bd7b30e83a8945e0491115baaead92498e4dcb7a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a58e72ee5e3631a789abfa20f64724af8e3ac328b29f45e443c929ac0dba01fab45956c102e9a9be61ef8a117f2946edba043e2b486d8e77eede05d7b0d5e7ac"} 11:43:02 INFO - Running post-run listener: copy_logs_to_upload_dir 11:43:02 INFO - Copying logs to upload dir... 11:43:02 INFO - mkdir: /builds/slave/test/build/upload/logs 11:43:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.785136 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-15 11:43:01.772688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:43:01.776297) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138 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/c727fb38240200cbc9b1746d070c29c8a8d11c7e9d03662cf8a0d42e5d9250f150980bcf4dac05348b8171058a096268535a27d4f3846b2bb86d90d26b20245c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5f24c3eb3ee3e9813a24b3db58917196be9bacc55ed01119326cac363c0061eef226843d95b9b089b7f871bd7b30e83a8945e0491115baaead92498e4dcb7a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a58e72ee5e3631a789abfa20f64724af8e3ac328b29f45e443c929ac0dba01fab45956c102e9a9be61ef8a117f2946edba043e2b486d8e77eede05d7b0d5e7ac"} build_url:https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/AKoycFEpTkWEJDK9xNXaRw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c727fb38240200cbc9b1746d070c29c8a8d11c7e9d03662cf8a0d42e5d9250f150980bcf4dac05348b8171058a096268535a27d4f3846b2bb86d90d26b20245c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5f24c3eb3ee3e9813a24b3db58917196be9bacc55ed01119326cac363c0061eef226843d95b9b089b7f871bd7b30e83a8945e0491115baaead92498e4dcb7a6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a58e72ee5e3631a789abfa20f64724af8e3ac328b29f45e443c929ac0dba01fab45956c102e9a9be61ef8a117f2946edba043e2b486d8e77eede05d7b0d5e7ac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:43:01.801226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:43:01.801534) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1468606936.228691-272808138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:43:01.883837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:43:01.884168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:43:01.884463) ========= ========= Total master_lag: 0.14 =========