builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1467916838.81 results: success (0) buildid: 20160707105522 builduid: 80f48615b4a74cf39f5d06b6be577303 revision: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:38.806883) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:38.807452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:38.807773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:38.840262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:38.840629) ========= 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=00204705a9daa57ed339a427000001b9-1467916837.466903-264862612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 11:40:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2016-07-07 11:40:38 (38.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151204 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:39.006474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:39.006826) ========= 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=00204705a9daa57ed339a427000001b9-1467916837.466903-264862612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077816 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:39.097772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 11:40:39.098289) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8be08b36d5d8ba576aca59a1994ddbdaed116d74 --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 8be08b36d5d8ba576aca59a1994ddbdaed116d74 --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=00204705a9daa57ed339a427000001b9-1467916837.466903-264862612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 11:40:39,054 truncating revision to first 12 chars 2016-07-07 11:40:39,054 Setting DEBUG logging. 2016-07-07 11:40:39,054 attempt 1/10 2016-07-07 11:40:39,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8be08b36d5d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 11:40:40,316 unpacking tar archive at: fx-team-8be08b36d5d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.604085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 11:40:40.717258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:40.717706) ========= script_repo_revision: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:40.718299) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:40.718699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 11:40:40.730568) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-07 11:40:40.730931) ========= /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=00204705a9daa57ed339a427000001b9-1467916837.466903-264862612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:40 INFO - MultiFileLogger online at 20160707 11:40:40 in /builds/slave/test 11:40:40 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:40:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:40 INFO - {'append_to_log': False, 11:40:40 INFO - 'base_work_dir': '/builds/slave/test', 11:40:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:40:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:40 INFO - 'branch': 'Fx-Team-Non-PGO', 11:40:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:40 INFO - 'config_files': ('talos/linux_config.py',), 11:40:40 INFO - 'default_actions': ('clobber', 11:40:40 INFO - 'read-buildbot-config', 11:40:40 INFO - 'download-and-extract', 11:40:40 INFO - 'populate-webroot', 11:40:40 INFO - 'create-virtualenv', 11:40:40 INFO - 'install', 11:40:40 INFO - 'run-tests'), 11:40:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:40 INFO - 'download_minidump_stackwalk': True, 11:40:40 INFO - 'download_symbols': 'ondemand', 11:40:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:40 INFO - 'installer_path': 'installer.exe', 11:40:40 INFO - 'log_level': 'info', 11:40:40 INFO - 'log_name': 'talos', 11:40:40 INFO - 'log_to_console': True, 11:40:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:40 INFO - 'opt_config_files': (), 11:40:40 INFO - 'pip_index': False, 11:40:40 INFO - 'sps_profile': False, 11:40:40 INFO - 'sps_profile_interval': 0, 11:40:40 INFO - 'suite': 'dromaeojs', 11:40:40 INFO - 'system_bits': '32', 11:40:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:40 INFO - 'title': 'talos-linux64-ix-016', 11:40:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:40 INFO - 'use_talos_json': True, 11:40:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:40 INFO - 'work_dir': 'build'} 11:40:40 INFO - ##### 11:40:40 INFO - ##### Running clobber step. 11:40:40 INFO - ##### 11:40:40 INFO - Running pre-action listener: _resource_record_pre_action 11:40:40 INFO - Running main action method: clobber 11:40:40 INFO - rmtree: /builds/slave/test/build 11:40:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:42 INFO - Running post-action listener: _resource_record_post_action 11:40:42 INFO - ##### 11:40:42 INFO - ##### Finished clobber step (success) 11:40:42 INFO - ##### 11:40:42 INFO - ##### 11:40:42 INFO - ##### Running read-buildbot-config step. 11:40:42 INFO - ##### 11:40:42 INFO - Running pre-action listener: _resource_record_pre_action 11:40:42 INFO - Running main action method: read_buildbot_config 11:40:42 INFO - Using buildbot properties: 11:40:42 INFO - { 11:40:42 INFO - "project": "", 11:40:42 INFO - "product": "firefox", 11:40:42 INFO - "script_repo_revision": "production", 11:40:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:40:42 INFO - "repository": "", 11:40:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:40:42 INFO - "buildid": "20160707105522", 11:40:42 INFO - "pgo_build": "False", 11:40:42 INFO - "basedir": "/builds/slave/test", 11:40:42 INFO - "buildnumber": 3144, 11:40:42 INFO - "slavename": "talos-linux64-ix-016", 11:40:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:40:42 INFO - "platform": "ubuntu64_hw", 11:40:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:40:42 INFO - "branch": "fx-team", 11:40:42 INFO - "repo_path": "integration/fx-team", 11:40:42 INFO - "revision": "8be08b36d5d8ba576aca59a1994ddbdaed116d74", 11:40:42 INFO - "stage_platform": "linux64", 11:40:42 INFO - "builduid": "80f48615b4a74cf39f5d06b6be577303", 11:40:42 INFO - "slavebuilddir": "test" 11:40:42 INFO - } 11:40:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:40:42 INFO - Running post-action listener: _resource_record_post_action 11:40:42 INFO - ##### 11:40:42 INFO - ##### Finished read-buildbot-config step (success) 11:40:42 INFO - ##### 11:40:42 INFO - ##### 11:40:42 INFO - ##### Running download-and-extract step. 11:40:42 INFO - ##### 11:40:42 INFO - Running pre-action listener: _resource_record_pre_action 11:40:42 INFO - Running main action method: download_and_extract 11:40:42 INFO - mkdir: /builds/slave/test/build/tests 11:40: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:40:42 INFO - https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:43 INFO - Downloaded 1361 bytes. 11:40:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:40:43 INFO - Using the following test package requirements: 11:40:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:40:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:40:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:40:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'jsshell-linux-x86_64.zip'], 11:40:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:40:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:40:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:40:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:40:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:40:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:40:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:40:43 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:40:43 INFO - https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:44 INFO - Downloaded 22734517 bytes. 11:40:44 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:40:44 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:40:45 INFO - Return code: 0 11:40:45 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:40:45 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:40:45 INFO - https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:46 INFO - Downloaded 22734517 bytes. 11:40:46 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:40:46 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:40:48 INFO - Return code: 0 11:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:48 INFO - https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:40:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:40:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:40:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:49 INFO - Downloaded 14403333 bytes. 11:40:49 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:40:49 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:40:49 INFO - Return code: 0 11:40: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:40:49 INFO - https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:40:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P3RBbXZ3RIazTP8k647hPA/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:40:50 INFO - Downloaded 56641994 bytes. 11:40:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:40:50 INFO - mkdir: /builds/slave/test/properties 11:40:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:40:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:40:50 INFO - Contents: 11:40:50 INFO - build_url:https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:40:51 INFO - Running post-action listener: _resource_record_post_action 11:40:51 INFO - Running post-action listener: set_extra_try_arguments 11:40:51 INFO - ##### 11:40:51 INFO - ##### Finished download-and-extract step (success) 11:40:51 INFO - ##### 11:40:51 INFO - ##### 11:40:51 INFO - ##### Running populate-webroot step. 11:40:51 INFO - ##### 11:40:51 INFO - Running pre-action listener: _resource_record_pre_action 11:40:51 INFO - Running main action method: populate_webroot 11:40:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:40:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:40:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:40:51 INFO - '--tppagecycles', 11:40:51 INFO - '7'], 11:40:51 INFO - 'tests': ['tsvgm']}}, 11:40:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:40:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:40:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:40:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:40:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['damp', 'tps']}, 11:40:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'tests': ['damp', 'tps']}, 11:40:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['dromaeo_dom']}, 11:40:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:40:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['basic_compositor_video']}, 11:40:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:40:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore', 11:40:51 INFO - 'tabpaint']}, 11:40:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore', 11:40:51 INFO - 'tabpaint']}, 11:40:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore', 11:40:51 INFO - 'tabpaint']}, 11:40:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore', 11:40:51 INFO - 'tabpaint']}, 11:40:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore', 11:40:51 INFO - 'tabpaint']}, 11:40:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore', 11:40:51 INFO - 'tabpaint']}, 11:40:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['tsvgx', 11:40:51 INFO - 'tsvgr_opacity', 11:40:51 INFO - 'tart', 11:40:51 INFO - 'tscrollx', 11:40:51 INFO - 'cart']}, 11:40:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:40:51 INFO - 'tsvgr_opacity', 11:40:51 INFO - 'tart', 11:40:51 INFO - 'tscrollx', 11:40:51 INFO - 'cart']}, 11:40:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--disable-e10s'], 11:40:51 INFO - 'tests': ['tp5o']}, 11:40:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'tests': ['tp5o']}, 11:40:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--disable-e10s', 11:40:51 INFO - '--xperf_path', 11:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:51 INFO - 'tests': ['tp5n']}, 11:40:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--xperf_path', 11:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:51 INFO - 'tests': ['tp5n']}}, 11:40:51 INFO - 'talos.zip': {'path': '', 11:40:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:40:51 INFO - Running post-action listener: _resource_record_post_action 11:40:51 INFO - ##### 11:40:51 INFO - ##### Finished populate-webroot step (success) 11:40:51 INFO - ##### 11:40:51 INFO - ##### 11:40:51 INFO - ##### Running create-virtualenv step. 11:40:51 INFO - ##### 11:40:51 INFO - Running pre-action listener: _resource_record_pre_action 11:40:51 INFO - Running main action method: create_virtualenv 11:40:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:40:51 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:40:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:40:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:40:51 INFO - Using real prefix '/usr' 11:40:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:40:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:58 INFO - Installing pip.................done. 11:40:58 INFO - Return code: 0 11:40:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:40:58 INFO - Using env: {'DISPLAY': ':0', 11:40:58 INFO - 'HOME': '/home/cltbld', 11:40:58 INFO - 'LANG': 'en_US.UTF-8', 11:40:58 INFO - 'LANGUAGE': 'en_US:en', 11:40:58 INFO - 'LOGNAME': 'cltbld', 11:40:58 INFO - 'MAIL': '/var/mail/cltbld', 11:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:58 INFO - 'MOZ_NO_REMOTE': '1', 11:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:58 INFO - 'NO_EM_RESTART': '1', 11:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:58 INFO - 'PWD': '/builds/slave/test', 11:40:58 INFO - 'SHELL': '/bin/bash', 11:40:58 INFO - 'SHLVL': '1', 11:40:58 INFO - 'TERM': 'linux', 11:40:58 INFO - 'TMOUT': '86400', 11:40:58 INFO - 'USER': 'cltbld', 11:40:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:58 INFO - '_': '/tools/buildbot/bin/python'} 11:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:59 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:40:59 INFO - Cleaning up... 11:40:59 INFO - Return code: 0 11:40:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:59 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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:40:59 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:40:59 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:40:59 INFO - Using env: {'DISPLAY': ':0', 11:40:59 INFO - 'HOME': '/home/cltbld', 11:40:59 INFO - 'LANG': 'en_US.UTF-8', 11:40:59 INFO - 'LANGUAGE': 'en_US:en', 11:40:59 INFO - 'LOGNAME': 'cltbld', 11:40:59 INFO - 'MAIL': '/var/mail/cltbld', 11:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:59 INFO - 'MOZ_NO_REMOTE': '1', 11:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:59 INFO - 'NO_EM_RESTART': '1', 11:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:59 INFO - 'PWD': '/builds/slave/test', 11:40:59 INFO - 'SHELL': '/bin/bash', 11:40:59 INFO - 'SHLVL': '1', 11:40:59 INFO - 'TERM': 'linux', 11:40:59 INFO - 'TMOUT': '86400', 11:40:59 INFO - 'USER': 'cltbld', 11:40:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:59 INFO - '_': '/tools/buildbot/bin/python'} 11:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:59 INFO - Downloading/unpacking psutil>=3.1.1 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:41:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:01 INFO - Installing collected packages: psutil 11:41:01 INFO - Running setup.py install for psutil 11:41:01 INFO - building 'psutil._psutil_linux' extension 11:41:01 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:41:02 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:41:02 INFO - building 'psutil._psutil_posix' extension 11:41:02 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:41:03 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:41:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:03 INFO - Successfully installed psutil 11:41:03 INFO - Cleaning up... 11:41:03 INFO - Return code: 0 11:41:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:03 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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:41:03 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:41:03 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:41:03 INFO - Using env: {'DISPLAY': ':0', 11:41:03 INFO - 'HOME': '/home/cltbld', 11:41:03 INFO - 'LANG': 'en_US.UTF-8', 11:41:03 INFO - 'LANGUAGE': 'en_US:en', 11:41:03 INFO - 'LOGNAME': 'cltbld', 11:41:03 INFO - 'MAIL': '/var/mail/cltbld', 11:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:03 INFO - 'MOZ_NO_REMOTE': '1', 11:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:03 INFO - 'NO_EM_RESTART': '1', 11:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:03 INFO - 'PWD': '/builds/slave/test', 11:41:03 INFO - 'SHELL': '/bin/bash', 11:41:03 INFO - 'SHLVL': '1', 11:41:03 INFO - 'TERM': 'linux', 11:41:03 INFO - 'TMOUT': '86400', 11:41:03 INFO - 'USER': 'cltbld', 11:41:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:03 INFO - '_': '/tools/buildbot/bin/python'} 11:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:41:05 INFO - Installing collected packages: mozsystemmonitor 11:41:05 INFO - Running setup.py install for mozsystemmonitor 11:41:05 INFO - Successfully installed mozsystemmonitor 11:41:05 INFO - Cleaning up... 11:41:05 INFO - Return code: 0 11:41:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:41:05 INFO - Using env: {'DISPLAY': ':0', 11:41:05 INFO - 'HOME': '/home/cltbld', 11:41:05 INFO - 'LANG': 'en_US.UTF-8', 11:41:05 INFO - 'LANGUAGE': 'en_US:en', 11:41:05 INFO - 'LOGNAME': 'cltbld', 11:41:05 INFO - 'MAIL': '/var/mail/cltbld', 11:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:05 INFO - 'MOZ_NO_REMOTE': '1', 11:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:05 INFO - 'NO_EM_RESTART': '1', 11:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:05 INFO - 'PWD': '/builds/slave/test', 11:41:05 INFO - 'SHELL': '/bin/bash', 11:41:05 INFO - 'SHLVL': '1', 11:41:05 INFO - 'TERM': 'linux', 11:41:05 INFO - 'TMOUT': '86400', 11:41:05 INFO - 'USER': 'cltbld', 11:41:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:05 INFO - '_': '/tools/buildbot/bin/python'} 11:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:05 INFO - Downloading/unpacking jsonschema==2.5.1 11:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:41:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:41:08 INFO - warning: no files found matching '*.txt' 11:41:08 INFO - no previously-included directories found matching 'build' 11:41:08 INFO - no previously-included directories found matching 'dist' 11:41:08 INFO - no previously-included directories found matching '.git*' 11:41:08 INFO - Installing collected packages: jsonschema, functools32 11:41:08 INFO - Running setup.py install for functools32 11:41:08 INFO - warning: no files found matching '*.txt' 11:41:08 INFO - no previously-included directories found matching 'build' 11:41:08 INFO - no previously-included directories found matching 'dist' 11:41:08 INFO - no previously-included directories found matching '.git*' 11:41:08 INFO - Successfully installed jsonschema functools32 11:41:08 INFO - Cleaning up... 11:41:08 INFO - Return code: 0 11:41:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:08 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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:41:08 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:41:08 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:41:08 INFO - Using env: {'DISPLAY': ':0', 11:41:08 INFO - 'HOME': '/home/cltbld', 11:41:08 INFO - 'LANG': 'en_US.UTF-8', 11:41:08 INFO - 'LANGUAGE': 'en_US:en', 11:41:08 INFO - 'LOGNAME': 'cltbld', 11:41:08 INFO - 'MAIL': '/var/mail/cltbld', 11:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:08 INFO - 'MOZ_NO_REMOTE': '1', 11:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:08 INFO - 'NO_EM_RESTART': '1', 11:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:08 INFO - 'PWD': '/builds/slave/test', 11:41:08 INFO - 'SHELL': '/bin/bash', 11:41:08 INFO - 'SHLVL': '1', 11:41:08 INFO - 'TERM': 'linux', 11:41:08 INFO - 'TMOUT': '86400', 11:41:08 INFO - 'USER': 'cltbld', 11:41:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:08 INFO - '_': '/tools/buildbot/bin/python'} 11:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:41:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:41:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:11 INFO - Downloading docopt-0.6.1.tar.gz 11:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:41:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:41:11 INFO - Running setup.py install for blobuploader 11:41:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:41:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:41:11 INFO - Running setup.py install for requests 11:41:11 INFO - Running setup.py install for docopt 11:41:11 INFO - Successfully installed blobuploader requests docopt 11:41:11 INFO - Cleaning up... 11:41:11 INFO - Return code: 0 11:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:11 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:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:11 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:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:11 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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:41:11 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:41:11 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:41:11 INFO - Using env: {'DISPLAY': ':0', 11:41:11 INFO - 'HOME': '/home/cltbld', 11:41:11 INFO - 'LANG': 'en_US.UTF-8', 11:41:11 INFO - 'LANGUAGE': 'en_US:en', 11:41:11 INFO - 'LOGNAME': 'cltbld', 11:41:11 INFO - 'MAIL': '/var/mail/cltbld', 11:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:11 INFO - 'MOZ_NO_REMOTE': '1', 11:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:11 INFO - 'NO_EM_RESTART': '1', 11:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:11 INFO - 'PWD': '/builds/slave/test', 11:41:11 INFO - 'SHELL': '/bin/bash', 11:41:11 INFO - 'SHLVL': '1', 11:41:11 INFO - 'TERM': 'linux', 11:41:11 INFO - 'TMOUT': '86400', 11:41:11 INFO - 'USER': 'cltbld', 11:41:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:11 INFO - '_': '/tools/buildbot/bin/python'} 11:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:11 INFO - Running setup.py (path:/tmp/pip-NZe3T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:12 INFO - Running setup.py (path:/tmp/pip-RWeA5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:12 INFO - Running setup.py (path:/tmp/pip-TPqrtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:12 INFO - Running setup.py (path:/tmp/pip-WJmiD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:12 INFO - Running setup.py (path:/tmp/pip-5Qy2OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:12 INFO - Running setup.py (path:/tmp/pip-ZmlIjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:12 INFO - Running setup.py (path:/tmp/pip-4B_xDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:12 INFO - Running setup.py (path:/tmp/pip-oEmU0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:12 INFO - Running setup.py (path:/tmp/pip-OXI07P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:12 INFO - Running setup.py (path:/tmp/pip-pRKA1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:12 INFO - Running setup.py (path:/tmp/pip-mKVI6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:12 INFO - Running setup.py (path:/tmp/pip-dUbU8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:12 INFO - Running setup.py (path:/tmp/pip-90iSTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:12 INFO - Running setup.py (path:/tmp/pip-z8kgxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:12 INFO - Running setup.py (path:/tmp/pip-6Udfhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:13 INFO - Running setup.py (path:/tmp/pip-vHovLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:13 INFO - Running setup.py (path:/tmp/pip-JMnrXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:41:13 INFO - Running setup.py install for manifestparser 11:41:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Running setup.py install for mozcrash 11:41:13 INFO - Running setup.py install for mozdebug 11:41:13 INFO - Running setup.py install for mozdevice 11:41:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Running setup.py install for mozfile 11:41:13 INFO - Running setup.py install for mozhttpd 11:41:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Running setup.py install for mozinfo 11:41:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Running setup.py install for mozInstall 11:41:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:13 INFO - Running setup.py install for mozleak 11:41:14 INFO - Running setup.py install for mozlog 11:41:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:14 INFO - Running setup.py install for moznetwork 11:41:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:14 INFO - Running setup.py install for mozprocess 11:41:14 INFO - Running setup.py install for mozprofile 11:41:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:14 INFO - Running setup.py install for mozrunner 11:41:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:14 INFO - Running setup.py install for mozscreenshot 11:41:14 INFO - Running setup.py install for moztest 11:41:14 INFO - Running setup.py install for mozversion 11:41:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:14 INFO - Cleaning up... 11:41:14 INFO - Return code: 0 11:41:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:14 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:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:14 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:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:14 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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:41:14 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:41:14 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:41:15 INFO - Using env: {'DISPLAY': ':0', 11:41:15 INFO - 'HOME': '/home/cltbld', 11:41:15 INFO - 'LANG': 'en_US.UTF-8', 11:41:15 INFO - 'LANGUAGE': 'en_US:en', 11:41:15 INFO - 'LOGNAME': 'cltbld', 11:41:15 INFO - 'MAIL': '/var/mail/cltbld', 11:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:15 INFO - 'MOZ_NO_REMOTE': '1', 11:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:15 INFO - 'NO_EM_RESTART': '1', 11:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:15 INFO - 'PWD': '/builds/slave/test', 11:41:15 INFO - 'SHELL': '/bin/bash', 11:41:15 INFO - 'SHLVL': '1', 11:41:15 INFO - 'TERM': 'linux', 11:41:15 INFO - 'TMOUT': '86400', 11:41:15 INFO - 'USER': 'cltbld', 11:41:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:15 INFO - '_': '/tools/buildbot/bin/python'} 11:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:15 INFO - Running setup.py (path:/tmp/pip-YK5NFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:15 INFO - Running setup.py (path:/tmp/pip-TEnOW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:15 INFO - Running setup.py (path:/tmp/pip-N6NRbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:15 INFO - Running setup.py (path:/tmp/pip-iACLTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:15 INFO - Running setup.py (path:/tmp/pip-ajh_C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:15 INFO - Running setup.py (path:/tmp/pip-p4Pyqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:15 INFO - Running setup.py (path:/tmp/pip-HcfrdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:15 INFO - Running setup.py (path:/tmp/pip-gPew0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:15 INFO - Running setup.py (path:/tmp/pip-jLa5ZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:15 INFO - Running setup.py (path:/tmp/pip-SQOSbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:15 INFO - Running setup.py (path:/tmp/pip-ALwnDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:16 INFO - Running setup.py (path:/tmp/pip-rzeAWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:16 INFO - Running setup.py (path:/tmp/pip-cHT6cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:16 INFO - Running setup.py (path:/tmp/pip-uePqBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:16 INFO - Running setup.py (path:/tmp/pip-eunMlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:16 INFO - Running setup.py (path:/tmp/pip-DPDNin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:16 INFO - Running setup.py (path:/tmp/pip-Qtmas9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:16 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:41:16 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:41:16 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:41:16 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:41:16 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:41:16 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:41:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:16 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:41:16 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:41:16 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:41:16 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:41:16 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:41:16 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:41:18 INFO - Downloading blessings-1.6.tar.gz 11:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:18 INFO - Installing collected packages: blessings 11:41:18 INFO - Running setup.py install for blessings 11:41:18 INFO - Successfully installed blessings 11:41:18 INFO - Cleaning up... 11:41:18 INFO - Return code: 0 11:41:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:18 INFO - Reading from file tmpfile_stdout 11:41:18 INFO - Current package versions: 11:41:18 INFO - argparse == 1.2.1 11:41:18 INFO - blessings == 1.6 11:41:18 INFO - blobuploader == 1.2.4 11:41:18 INFO - docopt == 0.6.1 11:41:18 INFO - functools32 == 3.2.3-2 11:41:18 INFO - jsonschema == 2.5.1 11:41:18 INFO - manifestparser == 1.1 11:41:18 INFO - mozInstall == 1.12 11:41:18 INFO - mozcrash == 0.17 11:41:18 INFO - mozdebug == 0.1 11:41:18 INFO - mozdevice == 0.48 11:41:18 INFO - mozfile == 1.2 11:41:18 INFO - mozhttpd == 0.7 11:41:18 INFO - mozinfo == 0.9 11:41:18 INFO - mozleak == 0.1 11:41:18 INFO - mozlog == 3.2 11:41:18 INFO - moznetwork == 0.27 11:41:18 INFO - mozprocess == 0.23 11:41:18 INFO - mozprofile == 0.28 11:41:18 INFO - mozrunner == 6.12 11:41:18 INFO - mozscreenshot == 0.1 11:41:18 INFO - mozsystemmonitor == 0.3 11:41:18 INFO - moztest == 0.7 11:41:18 INFO - mozversion == 1.4 11:41:18 INFO - psutil == 3.1.1 11:41:18 INFO - requests == 1.2.3 11:41:18 INFO - wsgiref == 0.1.2 11:41:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:18 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:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:18 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:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:18 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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:41:18 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:41:18 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:41:18 INFO - Using env: {'DISPLAY': ':0', 11:41:18 INFO - 'HOME': '/home/cltbld', 11:41:18 INFO - 'LANG': 'en_US.UTF-8', 11:41:18 INFO - 'LANGUAGE': 'en_US:en', 11:41:18 INFO - 'LOGNAME': 'cltbld', 11:41:18 INFO - 'MAIL': '/var/mail/cltbld', 11:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:18 INFO - 'MOZ_NO_REMOTE': '1', 11:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:18 INFO - 'NO_EM_RESTART': '1', 11:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:18 INFO - 'PWD': '/builds/slave/test', 11:41:18 INFO - 'SHELL': '/bin/bash', 11:41:18 INFO - 'SHLVL': '1', 11:41:18 INFO - 'TERM': 'linux', 11:41:18 INFO - 'TMOUT': '86400', 11:41:18 INFO - 'USER': 'cltbld', 11:41:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:18 INFO - '_': '/tools/buildbot/bin/python'} 11:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 INFO - Cleaning up... 11:41:19 INFO - Return code: 0 11:41:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41:19 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:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:19 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:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:19 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 0x2aa9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, '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': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', '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:41:19 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:41:19 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:41:19 INFO - Using env: {'DISPLAY': ':0', 11:41:19 INFO - 'HOME': '/home/cltbld', 11:41:19 INFO - 'LANG': 'en_US.UTF-8', 11:41:19 INFO - 'LANGUAGE': 'en_US:en', 11:41:19 INFO - 'LOGNAME': 'cltbld', 11:41:19 INFO - 'MAIL': '/var/mail/cltbld', 11:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:19 INFO - 'MOZ_NO_REMOTE': '1', 11:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:19 INFO - 'NO_EM_RESTART': '1', 11:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:19 INFO - 'PWD': '/builds/slave/test', 11:41:19 INFO - 'SHELL': '/bin/bash', 11:41:19 INFO - 'SHLVL': '1', 11:41:19 INFO - 'TERM': 'linux', 11:41:19 INFO - 'TMOUT': '86400', 11:41:19 INFO - 'USER': 'cltbld', 11:41:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:19 INFO - '_': '/tools/buildbot/bin/python'} 11:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:19 INFO - Cleaning up... 11:41:19 INFO - Return code: 0 11:41:19 INFO - Running post-action listener: _resource_record_post_action 11:41:19 INFO - Running post-action listener: _start_resource_monitoring 11:41:19 INFO - Starting resource monitoring. 11:41:19 INFO - ##### 11:41:19 INFO - ##### Finished create-virtualenv step (success) 11:41:19 INFO - ##### 11:41:19 INFO - ##### 11:41:19 INFO - ##### Running install step. 11:41:19 INFO - ##### 11:41:19 INFO - Running pre-action listener: _resource_record_pre_action 11:41:19 INFO - Running main action method: install 11:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:19 INFO - Reading from file tmpfile_stdout 11:41:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:19 INFO - Reading from file tmpfile_stdout 11:41:19 INFO - Output received: 11:41:19 INFO - Usage: mozinstall [options] installer 11:41:19 INFO - Options: 11:41:19 INFO - -h, --help show this help message and exit 11:41:19 INFO - -d DEST, --destination=DEST 11:41:19 INFO - Directory to install application into. [default: 11:41:19 INFO - "/builds/slave/test"] 11:41:19 INFO - --app=APP Application being installed. [default: firefox] 11:41:19 INFO - mkdir: /builds/slave/test/build/application 11:41:19 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:41:19 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:41:35 INFO - Reading from file tmpfile_stdout 11:41:35 INFO - Output received: 11:41:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:35 INFO - Running post-action listener: _resource_record_post_action 11:41:35 INFO - ##### 11:41:35 INFO - ##### Finished install step (success) 11:41:35 INFO - ##### 11:41:35 INFO - ##### 11:41:35 INFO - ##### Running run-tests step. 11:41:35 INFO - ##### 11:41:35 INFO - Running pre-action listener: _resource_record_pre_action 11:41:35 INFO - Running main action method: run_tests 11:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:35 INFO - Python 2.7.3 11:41:35 INFO - Return code: 0 11:41:35 INFO - grabbing minidump binary from tooltool 11:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:35 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 0x2d683b0>, '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 0x2d692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d69740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:35 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:41:35 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:41:35 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:41:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:36 INFO - Return code: 0 11:41:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:36 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/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:41:36 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/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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:41:36 INFO - Using env: {'DISPLAY': ':0', 11:41:36 INFO - 'HOME': '/home/cltbld', 11:41:36 INFO - 'LANG': 'en_US.UTF-8', 11:41:36 INFO - 'LANGUAGE': 'en_US:en', 11:41:36 INFO - 'LOGNAME': 'cltbld', 11:41:36 INFO - 'MAIL': '/var/mail/cltbld', 11:41:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:36 INFO - 'MOZ_NO_REMOTE': '1', 11:41:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:36 INFO - 'NO_EM_RESTART': '1', 11:41:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:36 INFO - 'PWD': '/builds/slave/test', 11:41:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:36 INFO - 'SHELL': '/bin/bash', 11:41:36 INFO - 'SHLVL': '1', 11:41:36 INFO - 'TERM': 'linux', 11:41:36 INFO - 'TMOUT': '86400', 11:41:36 INFO - 'USER': 'cltbld', 11:41:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467916837.466903-264862612', 11:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:36 INFO - '_': '/tools/buildbot/bin/python'} 11:41:36 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/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:41:36 INFO - mozversion application_buildid: 20160707105522 11:41:36 INFO - mozversion application_changeset: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 11:41:36 INFO - mozversion application_display_name: Nightly 11:41:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:36 INFO - mozversion application_name: Firefox 11:41:36 INFO - mozversion application_remotingname: firefox 11:41:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:41:36 INFO - mozversion application_vendor: Mozilla 11:41:36 INFO - mozversion application_version: 50.0a1 11:41:36 INFO - mozversion platform_buildid: 20160707105522 11:41:36 INFO - mozversion platform_changeset: 8be08b36d5d8ba576aca59a1994ddbdaed116d74 11:41:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:41:36 INFO - mozversion platform_version: 50.0a1 11:41:36 INFO - using testdate: 1467916896 11:41:36 INFO - actual date: 1467916896 11:41:36 INFO - starting webserver on 'localhost:45852' 11:41:36 INFO - SUITE-START | Running 2 tests 11:41:36 INFO - TEST-START | dromaeo_css 11:41:36 INFO - operating with platform_type : linux_ 11:41:36 INFO - Initialising browser for dromaeo_css test... 11:41:36 INFO - TEST-INFO | started process 3288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBPM4H/profile http://localhost:45852/getInfo.html) 11:41:42 INFO - PROCESS | 3288 | __metrics Screen width/height:1600/1200 11:41:42 INFO - PROCESS | 3288 | colorDepth:24 11:41:42 INFO - PROCESS | 3288 | Browser inner width/height: 1024/697 11:41:42 INFO - PROCESS | 3288 | __metrics 11:41:42 INFO - PROCESS | 3288 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:43 INFO - TEST-INFO | 3288: exit 0 11:41:43 INFO - Browser initialized. 11:41:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:43 INFO - TEST-INFO | started process 3370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBPM4H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:55 INFO - PROCESS | 3370 | RSS: Main: 159064064 11:41:55 INFO - PROCESS | 3370 | 11:42:46 INFO - PROCESS | 3370 | 1467916966482 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:44:59 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45852/tests/dromaeo/cssquery-ext.html) 11:45:00 INFO - PROCESS | 3370 | RSS: Main: 231845888 11:45:00 INFO - PROCESS | 3370 | 11:48:02 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-ext.html (next: http://localhost:45852/tests/dromaeo/cssquery-jquery.html) 11:48:03 INFO - PROCESS | 3370 | RSS: Main: 246251520 11:48:03 INFO - PROCESS | 3370 | 11:51:05 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45852/tests/dromaeo/cssquery-mootools.html) 11:51:06 INFO - PROCESS | 3370 | RSS: Main: 239251456 11:51:06 INFO - PROCESS | 3370 | 11:54:08 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45852/tests/dromaeo/cssquery-prototype.html) 11:54:09 INFO - PROCESS | 3370 | RSS: Main: 235446272 11:54:09 INFO - PROCESS | 3370 | 11:57:12 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45852/tests/dromaeo/cssquery-yui.html) 11:57:12 INFO - PROCESS | 3370 | RSS: Main: 218349568 11:57:12 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-yui.html (next: http://localhost:45852/tests/dromaeo/cssquery-dojo.html) 12:00:15 INFO - PROCESS | 3370 | RSS: Main: 279240704 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | __start_tp_report 12:00:15 INFO - PROCESS | 3370 | _x_x_mozilla_page_load 12:00:15 INFO - PROCESS | 3370 | _x_x_mozilla_page_load_details 12:00:15 INFO - PROCESS | 3370 | |i|pagename|runs| 12:00:15 INFO - PROCESS | 3370 | |0;dojo.html;2565.615157726342;2598.4673142005886;2602.7787638050763;2605.752453516915;2628.1721257803797;4541.250693635546;4598.517155698653;4652.069586082785;4694.765261736912;4699.365585645941;4671.836485723001;4703.553162449562;4711.340412342275;4728.078024785168;4734.644901632383;4099.323611604082;4263.786810659462;4347.2826983547675;4376.168527979689;4431.512533621315;4347.978260108695;4388.956110438902;4396.032872768002;4402.581754733295;4435.556444355571;4179.477565304337;4204.789760511978;4266.935995960063;4280.379344994958;4340.08858139791;4285.678574106923;4292.978535107304;4309.418228539138;4350.58669426404;4352.064306174188;4331.740095594275;4350.086481838817;4356.6514678825615;4397.670174736875;4402.339649052636;4558.544145585448;4654.4647365553055;4709.788059537329;4716.646251531115;4772.475027746945;5038.269450929594;5046.798128074873;5108.055009823194;5110.080185566597;5121.078205922932;5119.104156772587;5128.743562821881;5129.102407078746;5140.794368225266;5148.433672296044;4549.954500455019;4662.487126416091;4686.250199967989;4727.456342520585;4735.195016847076;5161.380634323905;5182.689038657692;5189.506996835295;5192.402873669576;5196.8960620787375;4767.856964291077;4922.4339200992345;4925.2119660854805;4962.03240368132;4968.22992436173;4917.754112294371;4964.429090654621;4966.006798640286;4967.453580106186;4979.825706100269;4933.45731969483;4936.925946110811;4940.184869496493;4947.628927830355;4986.351774269394;4849.539293767087;4875.317455556225;4929.2359684248995;4938.25926111079;4982.227754698028;4166.0626359068965;4173.97913010433;4201.831926722958;4240.872773816791;4244.129953359554;3660.5058317127377;3672.192117734094;3674.6876515496483;3675.0628589709454;3701.7408781385584;4161.188568229166;4220.91558168841;4226.344916537942;4256.59562341577;4259.850905218303;4977.228529577921;5005.849824505271;5022.547970682656;5037.219231019198;5043.193089105725;4225.873223803291;4274.722143060691;4275.059486912936;4285.250081235834;4321.632661223768;4351.934720979188;4458.108378324348;4498.707584007029;4499.775011249424;4505.05393867285;4689.577937985598;4690.085433340534;4717.363155974037;4762.571368576845;4769.3084502746215;5056.443791182894;5067.594592432671;5068.721220332917;5068.974655126701;5113.8721531962;4520.163769702615;4597.609203217764;4705;4714.057188562233;4761.714297142183;4893.168161412639;4917.459079501181;4932.926006109839;4938.30863679078;4994.400671919393;4947.109520286383;4980.9501904981935;4983.800647974041;4986.9251961221335;5027.798888044437;4806.735629540409;4808.35087263229;4849.175640141114;4892.217245240744;4959.156943319716;4853.053654537332;4867.269909513601;4872.074305881871;4901.289313049517;4911.582515486224;4792.113459010095;4806.4953179917;4808.855734327975;4812.085703716282;4853.927191092207;4769.117713223065;4788.688735232199;4810.4708482067645;4837.177679794373;4935.087008903364;4746.881327966828;4749.24012158053;4749.548792864673;4754.714717116845;4801.279808028824 12:00:15 INFO - PROCESS | 3370 | |1;ext.html;569.8034178208517;571.7770069672827;572.3989810698765;580.4079838564663;592.342499825194;27611.447771044568;40081.59918400815;41689.16621667565;41750.164996700085;45314.32028519567;41881.37177942333;42469.150616987645;42508.57491425085;42532.78733606335;42643.57356426443;7795.376369890423;7927.40544459165;7929.841403171962;7940.205979402042;7943.523388596674;7656.387489000895;7733.574653394061;7740.303372696456;7743.728969486069;7749.147593764681;7738.458307918448;7783.727569535039;7790.143084260727;7790.610469476532;7803.726869559567;7700.884486732675;7734.690612375498;7743.651535680936;7748.147703752583;7752.457327987043;7722.1891701371105;7780.649870755829;7780.883286750646;7785;7787.649555769947;39220.80389598062;39486.80256598699;39556.208875822325;39558.20883582341;39612.60387396118;3046.771492138076;3186.7291280241207;3625.274945010982;3628.3468975584383;3691.335559599271;28472.145835624964;28798.568021479696;30745;31432.214194645087;32612.836935815405;3536.929261414783;3592.8742494012586;3613.476045973345;3614.0784100054316;3629.872954446582;271361;275078;276437;276780;276985;58273.708631456575;58748;59077.40922590719;59106;59208.7039564808;34339.4849077264;35270.118247043516;35307.64692353095;37345.813270933475;37392.626073739455;15183.772243416357;15312.846871531143;15328.616784580474;15342.539723808304;15353;11547.422628868522;11662.067034637379;11665.76668466626;11671;11672.358020308964;19834.404967850987;19977.101030453665;19994.300199492947;20016.49958751043;20035.49911252201;7179.533330333512;7214.74748383804;7415;7455.962720186473;7676.424268179909;786.3080489169495;825.69449303758;926.6154545863391;968.3512046928574;1032.4682788363998;28620.856895715388;28900.42199156005;28944.855275723487;29372.85313573461;29406.411871762444;822.8313195794848;964.5322018820866;972.6401231544232;1002.774375765447;1035.9223058270659;14572.708545829024;14988;15094.698106038037;15285.465008724641;15342.23288835576;370621;371203;375124;377953;379008;49901.25148122781;50364.244536331986;50537.49462505328;50574.49425505772;50607;1064.6646306413454;1108.7893300273083;1132.3715337987496;1171.2562522798085;1222.022382094321;26883.193504194904;29608.407831843673;30283;30404;30849.383012339178;42783.572164279205;43257.3511397323;43302.133957321304;43471;43489.34765978449;281263;281729;282995;283280;283672;25896.35259118462;26793.598096028185;26801.927922882867;26806.59790103189;26873.328166795985;42377.36433953555;42571.14857702766;42976.57023429726;43856.34215486834;43958;36260;36767.81616091902;36905.07737306589;37179.44230836486;37653.62346376501;36253.818730906176;36657;36790;37468.62531374651;37864.81067594644;35563.288734224654;36579.634203657624;36763.26473470462;37067.814660926524;37372.62627373692;31733.5239971396;32622;32789.67210327866;32932.83533582317;33470.4979425304;25422.491550169263;25445.618315724907;25699;25794.226173214833;26172.214833555023 12:00:15 INFO - PROCESS | 3370 | |2;jquery.html;343.7194216374355;373.2683939478622;374.6178897524525;374.9981250093749;385.70493572417104;12959.416826242817;13885.652858678526;17455.91272043638;17463.301467941266;17464.214110365032;15947.601309967256;16986.32054717813;17145.742813857803;17158.571035724082;17163.82836171638;4968.2547617857335;5136.845894623168;5181.481851814826;5183.352080989876;5185.092608793465;3801.923961520768;5054.039732450841;5725.885482290351;6057.242844644419;6066.545009124311;6071.726772295236;6082.057281121433;6106.175666285039;6106.389361063881;6110.08348747687;5114.462981386957;5397.676139431646;5401.351837779453;5455.454454554552;5463.726813659301;4720.834770783006;5276.841694749163;5290.470952904679;5293.3647962244395;5296.073187192264;11828.822567661406;12205.816912746315;12248.387580620933;12323.260604363677;12338.938305308417;2028.5942811437624;2135.327371877869;2315.6526521021815;2379.4884099918427;2419.2742177346727;9021.323400744905;9100.817983640356;9510.4293742375;9560.56977436017;10687.358758474516;1687.0753712858962;1713.5459103337625;1736.4443378119006;1782.1267578886252;1831.075306969985;48247;66708.46519774687;70037.64981175112;70713.64643176751;71437.28562714359;9490.715278541655;9747.415155090575;9973.60105595768;10116.743165036949;10740.462976851126;13460.596182114552;13540.119892206974;13540.390682419315;13593.388297526635;13594.048416610742;7099.4736131731925;7118.252583478764;7185.928140718526;7194.496385253086;7413.555186688708;6825.249222585511;7040.964795175992;7186.317299856505;7285.817854553678;7411.925880741232;4184.205001049791;4234.618884300427;4306.461692288464;4310.073334233155;4369.9126017479475;1756.1219390304848;1786.8302511261409;1800.5498625343664;1816.6094289727507;1839.7332386804105;825.4345773145415;905.2757793764962;916.1113719692021;917.2891009467583;948.6015873333216;16545.338186472407;17128.40050598223;17171;17507.38724144649;17618.471445856645;831.0894908833154;841.869510225916;856.148132608059;858.0926759907359;858.6307887608264;9151.816963660689;9602.615895364246;9799.804003919882;10407.895921040845;10494.108000819862;379842;382136;385108;386786;394912;83937;86572;86681;86959;86984.13015869887;947.4930911962067;952.8665986761858;958.5590628310915;961.3030552849128;968.7239136845965;14866.331015104563;15124.924375378052;16322.836771632607;16421.26104325284;16581.75127373066;35846;39501.802490987364;39547.40678889761;41158.08998145171;41445.1710965785;52464.21303680524;52513.21230181627;53052.20421693601;53057;53119.73440132775;7040;7074.00963865049;7168.2831716827895;7236.710531578678;7387.556746595222;9232.499912891595;11236.325820450798;11307.491162897853;11670.124740644316;11737.589184378847;9708.2718796092;9871;9941.403515789076;10093.5457904393;10135.037171468994;9798.608055677692;9807;9982.301238913496;10113.443760593238;10237.43694096802;10152.746181345525;10220.591176352862;10227.642032529124;10277.434741089312;10376.118029967538;7120.857582848417;7155.212926577969;7164.426845852424;7215.350618444155;7496.25037496246;7353.264673532604;8549;9552.188064014637;10024.649137280161;10110 12:00:15 INFO - PROCESS | 3370 | |3;mootools.html;1193.2244041373112;1371.259519859276;1416.9291535423229;1518.817741870975;1717.914104294785;6706.6981985810635;7511.136219334778;7754.883676744853;7782.299593036626;7976.641051152697;7710;7832.7650170494835;7837.098733645633;7854.136045035041;7856.607169641509;2179.803817656407;2207.8012978831903;2210.8673479591193;2213.0373287619855;2213.347062616532;2188.518525924294;2208.977910220893;2244.708187935574;2246.921357752479;2249.876256805875;2194.3965409512352;2195.5938151441956;2200.1749343996003;2204.0742887987003;2235.0277629231337;2166.9891650541726;2173.793489618484;2176.68438076478;2177.858439201455;2179.7384313882276;2146.388279340396;2184.486645638274;2184.584928863527;2187.1798075721604;2187.89060546972;7686.769396918102;7796.454248202628;7847.6860925562905;7861.48900321483;7882.80292992674;4572.154151481986;4682.41469816273;4682.531746825324;4683.367745354401;4689.20283551797;2802.8598570071617;2876.4103358811394;2905.8547072646493;2913.1843083936533;2916.8979085732108;943.5329511891657;950.0974074629061;963.9951800241024;965.5413678502655;967.8741763570761;10475.47622618866;10557.313774604627;10557.524911379007;10578.894211057868;10587.788244235073;3844.154286057063;3939.8424063037733;4006.2988976928923;4034.8789536313957;4056.634902858757;8362.8327433451;8410.705625303084;8418.200270974248;8424.789380265542;8433.156684331641;4583.656225783079;4589.449266088091;4593.816247350135;4598.218302888517;4602.976985115053;3633.855335569287;3658.725595580342;4006.0157938768234;4262.978685106555;4276.3157894737315;3475.7740746851373;3571.321448924696;3583.104223944014;3608.6752192302292;3631;1070.9196810239264;1072.0565902006185;1074.5164675895721;1102.20090434436;1105.795427845851;768.611851015245;792.2631952284431;799.7760627024443;811.1037303779357;820.5363969357413;4740.478547359788;4799.520047995173;4801.255805350106;4911.140550403665;5021.121303771825;403.1051066632072;406.43302592882765;414.52122798168165;414.97925103744694;431.93305037719205;3261.6901394367496;3272.869085236564;3312.5528053712924;3382.340443613472;3423.554937858112;9235.584398702074;9711.805763884682;9725.416475011521;9739.610415583298;9758.658446954323;8869.512176830336;9570.808583828424;9605.327627066039;9622.615095396106;9634.277429192838;7058.894116588255;7318.597477138702;7352.852942941111;7369.373603243785;7393.445491588152;4915.5330243626795;5246.3179786629025;5291.3385826771655;5297.8145764898045;5325;9084.727458176265;9209.585568649562;9243.676471323472;9259.305552083486;9260;7869.331106855752;8891.955540222258;9272.536373181449;9392.577334019848;9468.195203407511;5628.831135065954;6686.431653309329;6721.227058888095;6882.105326307548;6890.552114112566;7624.809379765328;7631.236876312324;7669.233076692286;7673.769786906401;7702.653380597774;6565.606063636197;6759.526833121831;6859.039734437282;6924.203716572659;7005.019297298484;6556.541042127005;6568.343165683394;6591.274959754519;6663.500237482305;6733.192016957996;5453;5613.46672066153;5786.739596718242;5824.737886795189;5831.125331200354;4083.7549747015273;4200.600942910419;4203.117345357509;4218.957810421856;4269.850555230552;4051.39229115635;4201.285781417228;4206.558311377384;4243.172581346607;4275.0594869128745 12:00:15 INFO - PROCESS | 3370 | |4;prototype.html;285.6457992089808;290.925813917451;292.8199157518126;296.09542846603625;309.47698389721364;4850.757462126893;4877.878053048676;4915.3610030696;4916.164252077147;4918.704877707336;4764.26153946138;4770.379850619423;4812.518748125186;4819.469858315591;4820.3733514643045;3535.133892196409;3637.909052273688;3662.194317250214;3752.1932784451337;3842.750221235625;3770.7549009314307;3795.35478968576;3796.164843734388;3799.8720716398766;3800.619938006205;3541.238633693755;3710.684591809699;3723.590405055442;3753.2976257094847;3756.7182461315374;3653.433717773736;3781.0925377909102;3782.6028267032116;3794.5067141271734;3800.4869342638667;3362.6301106878223;3362.7646064775477;3363.562736844219;3367.1582104473882;3379.5437615921783;4687.742174180418;4706.74112923789;4708.293755936603;4716.080364328957;4719.882002949919;4225.894352641178;4319.654427645813;4324.502682191525;4334.934975975331;4338.566143385668;4967.975160124212;4979.203327467588;5001.599872010231;5052.848414547533;5053.469385714484;3679.6872265857432;3680.5031320771623;3684.5762737285286;3691.446283057536;3695.2978934002454;4980.975095124538;5210.895782084337;5224.555912747383;5233.241180028913;5247.842564723026;3608.4767708682093;3613.7713177519768;3621.4386770050683;3626.220362622049;3637.0725465006785;3663.102539877747;3666.9915773162593;3668.248009158116;3670.50448189491;3672.338978983755;4213.5154457237195;4228.957710422918;4229.851955181553;4233.238017156879;4236.279832428495;4754.738489383117;5014;5023.171176755867;5023.949760502422;5055.772490237948;1323.4772264955482;1324.8012798080172;1334.7063645997864;1335.065454182057;1337.224409842289;871.1984973824098;871.7733389318822;911.7674992876774;930.2046750028763;930.8789857318505;4301.978490107529;4308.827646894152;4311.956880431218;4330.501992270866;4341.479022517318;5094.133997220481;5110.693358398508;5116.258142569307;5122.078025955364;5123.769430375642;4195.391668208093;4303.289957157097;4304.569543045671;4310.870673879788;4311.9784401077795;2688.3332333953076;2688.986555067212;2717.687465941442;2732.221316924667;2748.491529067129;4726.550977657117;4752.239641657318;4766.189747742892;4769.403824521934;4799.952000480021;5106.4382917879;5157.638965272395;5194.92207616886;5219.191025390995;5237.266782650432;4712.69367491112;4723.50403207672;4743.478217396084;4749.453812811502;4765.11845308619;5030.673006254582;5058.595312375075;5070.138076527073;5106.340439357149;5123.948760512496;4810.95189048105;4974.154393753143;4976.825811096594;4980.775865086152;5014.122528557561;4688.156131896155;4705.835295764632;4707.905841883075;4728.38530990969;4733.124371991193;3745.906352341104;3777.8299976500575;3778.6599206071587;3781.0925377909653;3787.6780473660046;4874.2201247800185;5064.7467626619255;5094.395265491358;5100.526244771358;5119.104156772624;4902.3872015998;4910.337104490848;4915.139850526215;4918.655694101379;4925.310456536016;4914.149793120053;4921;4972.428170760409;4982.451930287738;4988.032120888066;4692.577668009895;4840.249761287007;4906.582940450102;4922.803087876445;4924.113659541317;4738.241881298975;4863.2461968394955;5033.094043072282;5046.1673823818655;5060.1903695408555;4934.481879402754;4939.777710003131;4960.156773348467;5004.549590536869;5016.974915125401 12:00:15 INFO - PROCESS | 3370 | |5;yui.html;616.5067945643486;633.5976654824185;674.9122614060173;731.9597422141784;760.6691089376122;12764.297963611998;13333.466661333547;13731.931340343297;14007.859921400783;14034.228117453536;13179.341032948361;13210.669733256673;13308.733825323488;13327.26700031498;13330.000249981242;625.4902254662459;748.2293237964905;777.607308309303;798.4650284309497;799.0810567846993;802.4022103532876;803.0203152154362;805.2350267246111;805.4844899264475;806.1253539909176;806.5967016491754;808.0384342632278;808.4138999225573;808.7048227397016;808.8058865872207;646.6734299178931;664.8537321789198;665.1652176518487;665.930077341877;808.030363563723;582.0919365789382;602.7167231401278;606.5147881694627;606.9666168360739;607.0590584593906;13262.933685331607;13299.401526931215;13308.134971226838;13311;13315.201087934754;12793.87206127936;13273.734525309439;13340.132891362031;13368.86631133686;13579.370475542899;11924.70188245292;11953.52185912571;12141.15011949164;12179.208351457128;12636.178648387917;4118.91762164758;4168.499780026386;4203.453551038346;4249.447571815645;4253.468316460442;62588.37411625871;62850.37149628536;62897.05654415142;64732.85037921437;65375.3462465374;10316.48417579118;10509.720447006172;10668.093212077061;10699.25105242641;10978.670639880816;19191.232350705814;19205.711914321295;19214.80785192158;19216.903915480332;19232.519187020436;6612.107365505692;6614.404703576605;6909.930900691029;7059.364657180879;7066.893996590055;3499.2651543175707;3589.1565482111682;3611.2777444511203;3640.4903313536124;3730.0488375464083;2856.2716507290925;2964.925876853096;2969.287371030937;2990.5065664165604;3002.8048176868433;489.4175930642524;506.7415618034755;515.1962937816943;516.2282387830218;523.9083160446907;408.2849053792305;421.147176966645;489.3589397888777;545.1169106048148;571.1580154003306;7253.274672532704;7368.8894666580045;7453.515521491086;7581.166071732105;7591.582462964479;435.56225992876955;506.4985664192423;545.4926917966329;562.5696342298145;581.7294957844538;3400.302937897725;3409.761316707856;3452.5511683480986;3497.7726447780815;3595.388783906742;88383;93874.53062734642;96074.51962740142;97586;97618.51190744001;57923.71038144867;73701.6314918422;74961.62519187479;74989.62505187548;76594.23405765982;69512.6524367375;73005.26994730091;74189;74567.99999999891;75791.62104189444;6511.902321465087;6607.405333520006;6639.103720997604;6740.157480314961;6827.146606674166;32094.518582221754;41212.58787412087;42931;43243;43314.350284745124;47012.7649361751;59344.406555933885;61147.38852611595;61467.69266153641;62087.843722782134;9275.82018225703;9471.526423678652;9718.514074296398;9766.56050477716;9778.951105244429;10262.384256944608;10320.43237621938;10350.275480716278;10357.274990750575;10622.521986510472;7980.441369104107;9801;10071.395716257048;11150.55397784112;11762.882371176178;12322.199057061262;12674.619761407173;12752.48990040425;12754.48982040708;13009.544665936646;11972.341521216416;12024.939875300568;12070.939645301718;12078.698032549257;12182.573609923964;10400.167986561208;10843.512041957973;11183.776324473627;11358.204925655125;11519.193656444304;10016.64941727036;10340.638077667245;10392.636257730943;10448.42533660656;10488.68533943983 12:00:15 INFO - PROCESS | 3370 | __end_tp_report 12:00:15 INFO - PROCESS | 3370 | __start_cc_report 12:00:15 INFO - PROCESS | 3370 | _x_x_mozilla_cycle_collect,1047 12:00:15 INFO - PROCESS | 3370 | __end_cc_report 12:00:15 INFO - PROCESS | 3370 | __startTimestamp1467918015789__endTimestamp 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | ------- Summary: start ------- 12:00:15 INFO - PROCESS | 3370 | Number of tests: 6 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | [#0] dojo.html Cycles:165 Average:4620.21 Median:4749.24 stddev:493.70 (10.4%) stddev-sans-first:468.17 12:00:15 INFO - PROCESS | 3370 | Values: 2565.6 2598.5 2602.8 2605.8 2628.2 4541.3 4598.5 4652.1 4694.8 4699.4 4671.8 4703.6 4711.3 4728.1 4734.6 4099.3 4263.8 4347.3 4376.2 4431.5 4348.0 4389.0 4396.0 4402.6 4435.6 4179.5 4204.8 4266.9 4280.4 4340.1 4285.7 4293.0 4309.4 4350.6 4352.1 4331.7 4350.1 4356.7 4397.7 4402.3 4558.5 4654.5 4709.8 4716.6 4772.5 5038.3 5046.8 5108.1 5110.1 5121.1 5119.1 5128.7 5129.1 5140.8 5148.4 4550.0 4662.5 4686.3 4727.5 4735.2 5161.4 5182.7 5189.5 5192.4 5196.9 4767.9 4922.4 4925.2 4962.0 4968.2 4917.8 4964.4 4966.0 4967.5 4979.8 4933.5 4936.9 4940.2 4947.6 4986.4 4849.5 4875.3 4929.2 4938.3 4982.2 4166.1 4174.0 4201.8 4240.9 4244.1 3660.5 3672.2 3674.7 3675.1 3701.7 4161.2 4220.9 4226.3 4256.6 4259.9 4977.2 5005.8 5022.5 5037.2 5043.2 4225.9 4274.7 4275.1 4285.3 4321.6 4351.9 4458.1 4498.7 4499.8 4505.1 4689.6 4690.1 4717.4 4762.6 4769.3 5056.4 5067.6 5068.7 5069.0 5113.9 4520.2 4597.6 4705.0 4714.1 4761.7 4893.2 4917.5 4932.9 4938.3 4994.4 4947.1 4981.0 4983.8 4986.9 5027.8 4806.7 4808.4 4849.2 4892.2 4959.2 4853.1 4867.3 4872.1 4901.3 4911.6 4792.1 4806.5 4808.9 4812.1 4853.9 4769.1 4788.7 4810.5 4837.2 4935.1 4746.9 4749.2 4749.5 4754.7 4801.3 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | [#1] ext.html Cycles:180 Average:46920.84 Median:187156.17 stddev:82456.62 (44.1%) stddev-sans-first:82614.49 12:00:15 INFO - PROCESS | 3370 | Values: 569.8 571.8 572.4 580.4 592.3 27611.4 40081.6 41689.2 41750.2 45314.3 41881.4 42469.2 42508.6 42532.8 42643.6 7795.4 7927.4 7929.8 7940.2 7943.5 7656.4 7733.6 7740.3 7743.7 7749.1 7738.5 7783.7 7790.1 7790.6 7803.7 7700.9 7734.7 7743.7 7748.1 7752.5 7722.2 7780.6 7780.9 7785.0 7787.6 39220.8 39486.8 39556.2 39558.2 39612.6 3046.8 3186.7 3625.3 3628.3 3691.3 28472.1 28798.6 30745.0 31432.2 32612.8 3536.9 3592.9 3613.5 3614.1 3629.9 271361.0 275078.0 276437.0 276780.0 276985.0 58273.7 58748.0 59077.4 59106.0 59208.7 34339.5 35270.1 35307.6 37345.8 37392.6 15183.8 15312.8 15328.6 15342.5 15353.0 11547.4 11662.1 11665.8 11671.0 11672.4 19834.4 19977.1 19994.3 20016.5 20035.5 7179.5 7214.7 7415.0 7456.0 7676.4 786.3 825.7 926.6 968.4 1032.5 28620.9 28900.4 28944.9 29372.9 29406.4 822.8 964.5 972.6 1002.8 1035.9 14572.7 14988.0 15094.7 15285.5 15342.2 370621.0 371203.0 375124.0 377953.0 379008.0 49901.3 50364.2 50537.5 50574.5 50607.0 1064.7 1108.8 1132.4 1171.3 1222.0 26883.2 29608.4 30283.0 30404.0 30849.4 42783.6 43257.4 43302.1 43471.0 43489.3 281263.0 281729.0 282995.0 283280.0 283672.0 25896.4 26793.6 26801.9 26806.6 26873.3 42377.4 42571.1 42976.6 43856.3 43958.0 36260.0 36767.8 36905.1 37179.4 37653.6 36253.8 36657.0 36790.0 37468.6 37864.8 35563.3 36579.6 36763.3 37067.8 37372.6 31733.5 32622.0 32789.7 32932.8 33470.5 25422.5 25445.6 25699.0 25794.2 26172.2 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | [#2] jquery.html Cycles:180 Average:24170.45 Median:5125.65 stddev:63983.88 (1248.3%) stddev-sans-first:64138.36 12:00:15 INFO - PROCESS | 3370 | Values: 343.7 373.3 374.6 375.0 385.7 12959.4 13885.7 17455.9 17463.3 17464.2 15947.6 16986.3 17145.7 17158.6 17163.8 4968.3 5136.8 5181.5 5183.4 5185.1 3801.9 5054.0 5725.9 6057.2 6066.5 6071.7 6082.1 6106.2 6106.4 6110.1 5114.5 5397.7 5401.4 5455.5 5463.7 4720.8 5276.8 5290.5 5293.4 5296.1 11828.8 12205.8 12248.4 12323.3 12338.9 2028.6 2135.3 2315.7 2379.5 2419.3 9021.3 9100.8 9510.4 9560.6 10687.4 1687.1 1713.5 1736.4 1782.1 1831.1 48247.0 66708.5 70037.6 70713.6 71437.3 9490.7 9747.4 9973.6 10116.7 10740.5 13460.6 13540.1 13540.4 13593.4 13594.0 7099.5 7118.3 7185.9 7194.5 7413.6 6825.2 7041.0 7186.3 7285.8 7411.9 4184.2 4234.6 4306.5 4310.1 4369.9 1756.1 1786.8 1800.5 1816.6 1839.7 825.4 905.3 916.1 917.3 948.6 16545.3 17128.4 17171.0 17507.4 17618.5 831.1 841.9 856.1 858.1 858.6 9151.8 9602.6 9799.8 10407.9 10494.1 379842.0 382136.0 385108.0 386786.0 394912.0 83937.0 86572.0 86681.0 86959.0 86984.1 947.5 952.9 958.6 961.3 968.7 14866.3 15124.9 16322.8 16421.3 16581.8 35846.0 39501.8 39547.4 41158.1 41445.2 52464.2 52513.2 53052.2 53057.0 53119.7 7040.0 7074.0 7168.3 7236.7 7387.6 9232.5 11236.3 11307.5 11670.1 11737.6 9708.3 9871.0 9941.4 10093.5 10135.0 9798.6 9807.0 9982.3 10113.4 10237.4 10152.7 10220.6 10227.6 10277.4 10376.1 7120.9 7155.2 7164.4 7215.4 7496.3 7353.3 8549.0 9552.2 10024.6 10110.0 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | [#3] mootools.html Cycles:180 Average:5034.25 Median:4770.00 stddev:2882.17 (60.4%) stddev-sans-first:2875.80 12:00:15 INFO - PROCESS | 3370 | Values: 1193.2 1371.3 1416.9 1518.8 1717.9 6706.7 7511.1 7754.9 7782.3 7976.6 7710.0 7832.8 7837.1 7854.1 7856.6 2179.8 2207.8 2210.9 2213.0 2213.3 2188.5 2209.0 2244.7 2246.9 2249.9 2194.4 2195.6 2200.2 2204.1 2235.0 2167.0 2173.8 2176.7 2177.9 2179.7 2146.4 2184.5 2184.6 2187.2 2187.9 7686.8 7796.5 7847.7 7861.5 7882.8 4572.2 4682.4 4682.5 4683.4 4689.2 2802.9 2876.4 2905.9 2913.2 2916.9 943.5 950.1 964.0 965.5 967.9 10475.5 10557.3 10557.5 10578.9 10587.8 3844.2 3939.8 4006.3 4034.9 4056.6 8362.8 8410.7 8418.2 8424.8 8433.2 4583.7 4589.4 4593.8 4598.2 4603.0 3633.9 3658.7 4006.0 4263.0 4276.3 3475.8 3571.3 3583.1 3608.7 3631.0 1070.9 1072.1 1074.5 1102.2 1105.8 768.6 792.3 799.8 811.1 820.5 4740.5 4799.5 4801.3 4911.1 5021.1 403.1 406.4 414.5 415.0 431.9 3261.7 3272.9 3312.6 3382.3 3423.6 9235.6 9711.8 9725.4 9739.6 9758.7 8869.5 9570.8 9605.3 9622.6 9634.3 7058.9 7318.6 7352.9 7369.4 7393.4 4915.5 5246.3 5291.3 5297.8 5325.0 9084.7 9209.6 9243.7 9259.3 9260.0 7869.3 8892.0 9272.5 9392.6 9468.2 5628.8 6686.4 6721.2 6882.1 6890.6 7624.8 7631.2 7669.2 7673.8 7702.7 6565.6 6759.5 6859.0 6924.2 7005.0 6556.5 6568.3 6591.3 6663.5 6733.2 5453.0 5613.5 5786.7 5824.7 5831.1 4083.8 4200.6 4203.1 4219.0 4269.9 4051.4 4201.3 4206.6 4243.2 4275.1 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | [#4] prototype.html Cycles:180 Average:4145.67 Median:4725.03 stddev:1180.86 (25.0%) stddev-sans-first:1148.08 12:00:15 INFO - PROCESS | 3370 | Values: 285.6 290.9 292.8 296.1 309.5 4850.8 4877.9 4915.4 4916.2 4918.7 4764.3 4770.4 4812.5 4819.5 4820.4 3535.1 3637.9 3662.2 3752.2 3842.8 3770.8 3795.4 3796.2 3799.9 3800.6 3541.2 3710.7 3723.6 3753.3 3756.7 3653.4 3781.1 3782.6 3794.5 3800.5 3362.6 3362.8 3363.6 3367.2 3379.5 4687.7 4706.7 4708.3 4716.1 4719.9 4225.9 4319.7 4324.5 4334.9 4338.6 4968.0 4979.2 5001.6 5052.8 5053.5 3679.7 3680.5 3684.6 3691.4 3695.3 4981.0 5210.9 5224.6 5233.2 5247.8 3608.5 3613.8 3621.4 3626.2 3637.1 3663.1 3667.0 3668.2 3670.5 3672.3 4213.5 4229.0 4229.9 4233.2 4236.3 4754.7 5014.0 5023.2 5023.9 5055.8 1323.5 1324.8 1334.7 1335.1 1337.2 871.2 871.8 911.8 930.2 930.9 4302.0 4308.8 4312.0 4330.5 4341.5 5094.1 5110.7 5116.3 5122.1 5123.8 4195.4 4303.3 4304.6 4310.9 4312.0 2688.3 2689.0 2717.7 2732.2 2748.5 4726.6 4752.2 4766.2 4769.4 4800.0 5106.4 5157.6 5194.9 5219.2 5237.3 4712.7 4723.5 4743.5 4749.5 4765.1 5030.7 5058.6 5070.1 5106.3 5123.9 4811.0 4974.2 4976.8 4980.8 5014.1 4688.2 4705.8 4707.9 4728.4 4733.1 3745.9 3777.8 3778.7 3781.1 3787.7 4874.2 5064.7 5094.4 5100.5 5119.1 4902.4 4910.3 4915.1 4918.7 4925.3 4914.1 4921.0 4972.4 4982.5 4988.0 4692.6 4840.2 4906.6 4922.8 4924.1 4738.2 4863.2 5033.1 5046.2 5060.2 4934.5 4939.8 4960.2 5004.5 5017.0 12:00:15 INFO - PROCESS | 3370 | 12:00:15 INFO - PROCESS | 3370 | [#5] yui.html Cycles:180 Average:17083.84 Median:23724.16 stddev:23974.76 (101.1%) stddev-sans-first:24010.13 12:00:15 INFO - PROCESS | 3370 | Values: 616.5 633.6 674.9 732.0 760.7 12764.3 13333.5 13731.9 14007.9 14034.2 13179.3 13210.7 13308.7 13327.3 13330.0 625.5 748.2 777.6 798.5 799.1 802.4 803.0 805.2 805.5 806.1 806.6 808.0 808.4 808.7 808.8 646.7 664.9 665.2 665.9 808.0 582.1 602.7 606.5 607.0 607.1 13262.9 13299.4 13308.1 13311.0 13315.2 12793.9 13273.7 13340.1 13368.9 13579.4 11924.7 11953.5 12141.2 12179.2 12636.2 4118.9 4168.5 4203.5 4249.4 4253.5 62588.4 62850.4 62897.1 64732.9 65375.3 10316.5 10509.7 10668.1 10699.3 10978.7 19191.2 19205.7 19214.8 19216.9 19232.5 6612.1 6614.4 6909.9 7059.4 7066.9 3499.3 3589.2 3611.3 3640.5 3730.0 2856.3 2964.9 2969.3 2990.5 3002.8 489.4 506.7 515.2 516.2 523.9 408.3 421.1 489.4 545.1 571.2 7253.3 7368.9 7453.5 7581.2 7591.6 435.6 506.5 545.5 562.6 581.7 3400.3 3409.8 3452.6 3497.8 3595.4 88383.0 93874.5 96074.5 97586.0 97618.5 57923.7 73701.6 74961.6 74989.6 76594.2 69512.7 73005.3 74189.0 74568.0 75791.6 6511.9 6607.4 6639.1 6740.2 6827.1 32094.5 41212.6 42931.0 43243.0 43314.4 47012.8 59344.4 61147.4 61467.7 62087.8 9275.8 9471.5 9718.5 9766.6 9779.0 10262.4 10320.4 10350.3 10357.3 10622.5 7980.4 9801.0 10071.4 11150.6 11762.9 12322.2 12674.6 12752.5 12754.5 13009.5 11972.3 12024.9 12070.9 12078.7 12182.6 10400.2 10843.5 11183.8 11358.2 11519.2 10016.6 10340.6 10392.6 10448.4 10488.7 12:00:15 INFO - PROCESS | 3370 | -------- Summary: end -------- 12:00:15 INFO - PROCESS | 3370 | 12:00:16 INFO - TEST-INFO | 3370: exit 0 12:00:16 INFO - TEST-OK | dromaeo_css | took 1120157ms 12:00:16 INFO - TEST-START | kraken 12:00:16 INFO - operating with platform_type : linux_ 12:00:16 INFO - Initialising browser for kraken test... 12:00:16 INFO - TEST-INFO | started process 3558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9J6Up/profile http://localhost:45852/getInfo.html) 12:00:20 INFO - PROCESS | 3558 | __metrics Screen width/height:1600/1200 12:00:20 INFO - PROCESS | 3558 | colorDepth:24 12:00:20 INFO - PROCESS | 3558 | Browser inner width/height: 1024/697 12:00:20 INFO - PROCESS | 3558 | __metrics 12:00:21 INFO - PROCESS | 3558 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:22 INFO - TEST-INFO | 3558: exit 0 12:00:22 INFO - Browser initialized. 12:00:22 INFO - Running cycle 1/1 for kraken test... 12:00:22 INFO - TEST-INFO | started process 3639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9J6Up/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:34 INFO - PROCESS | 3639 | RSS: Main: 158281728 12:00:34 INFO - PROCESS | 3639 | 12:00:37 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:37 INFO - PROCESS | 3639 | RSS: Main: 216686592 12:00:37 INFO - PROCESS | 3639 | 12:00:40 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-dft) 12:00:41 INFO - PROCESS | 3639 | RSS: Main: 203448320 12:00:41 INFO - PROCESS | 3639 | 12:00:44 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-fft) 12:00:45 INFO - PROCESS | 3639 | RSS: Main: 270987264 12:00:45 INFO - PROCESS | 3639 | 12:00:47 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-oscillator) 12:00:47 INFO - PROCESS | 3639 | RSS: Main: 181637120 12:00:47 INFO - PROCESS | 3639 | 12:00:50 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:00:50 INFO - PROCESS | 3639 | RSS: Main: 186130432 12:00:50 INFO - PROCESS | 3639 | 12:00:53 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-darkroom) 12:00:54 INFO - PROCESS | 3639 | RSS: Main: 221888512 12:00:54 INFO - PROCESS | 3639 | 12:00:58 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-desaturate) 12:00:58 INFO - PROCESS | 3639 | RSS: Main: 217227264 12:00:58 INFO - PROCESS | 3639 | 12:01:01 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45852/tests/kraken/driver.html?testName=json-parse-financial) 12:01:02 INFO - PROCESS | 3639 | RSS: Main: 220422144 12:01:02 INFO - PROCESS | 3639 | 12:01:03 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45852/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:01:04 INFO - PROCESS | 3639 | RSS: Main: 206110720 12:01:04 INFO - PROCESS | 3639 | 12:01:06 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:01:07 INFO - PROCESS | 3639 | RSS: Main: 210972672 12:01:07 INFO - PROCESS | 3639 | 12:01:09 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:01:09 INFO - PROCESS | 3639 | RSS: Main: 212557824 12:01:09 INFO - PROCESS | 3639 | 12:01:12 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:01:13 INFO - PROCESS | 3639 | RSS: Main: 224428032 12:01:13 INFO - PROCESS | 3639 | 12:01:16 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:01:16 INFO - PROCESS | 3639 | RSS: Main: 225058816 12:01:16 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45852/tests/kraken/driver.html?testName=ai-astar) 12:01:18 INFO - PROCESS | 3639 | RSS: Main: 268177408 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | __start_tp_report 12:01:18 INFO - PROCESS | 3639 | _x_x_mozilla_page_load 12:01:18 INFO - PROCESS | 3639 | _x_x_mozilla_page_load_details 12:01:18 INFO - PROCESS | 3639 | |i|pagename|runs| 12:01:18 INFO - PROCESS | 3639 | |0;ai-astar;104;115;113;113;114;114;113;114;113;113 12:01:18 INFO - PROCESS | 3639 | |1;audio-beat-detection;154;127;126;202;122;122;144;124;153;125 12:01:18 INFO - PROCESS | 3639 | |2;audio-dft;162;162;161;163;162;160;160;160;160;161 12:01:18 INFO - PROCESS | 3639 | |3;audio-fft;75;75;79;133;76;79;74;75;104;76 12:01:18 INFO - PROCESS | 3639 | |4;audio-oscillator;86;88;121;85;84;85;128;87;86;124 12:01:18 INFO - PROCESS | 3639 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 12:01:18 INFO - PROCESS | 3639 | |6;imaging-darkroom;146;147;147;147;146;145;146;147;146;146 12:01:18 INFO - PROCESS | 3639 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 12:01:18 INFO - PROCESS | 3639 | |8;json-parse-financial;63;64;63;63;64;65;64;64;65;64 12:01:18 INFO - PROCESS | 3639 | |9;json-stringify-tinderbox;65;66;66;66;65;65;68;66;65;65 12:01:18 INFO - PROCESS | 3639 | |10;stanford-crypto-aes;88;85;79;79;87;78;78;79;79;84 12:01:18 INFO - PROCESS | 3639 | |11;stanford-crypto-ccm;138;129;144;136;138;124;131;133;177;131 12:01:18 INFO - PROCESS | 3639 | |12;stanford-crypto-pbkdf2;168;166;167;172;165;172;166;174;167;169 12:01:18 INFO - PROCESS | 3639 | |13;stanford-crypto-sha256-iterative;67;66;67;66;70;66;67;67;68;66 12:01:18 INFO - PROCESS | 3639 | __end_tp_report 12:01:18 INFO - PROCESS | 3639 | __start_cc_report 12:01:18 INFO - PROCESS | 3639 | _x_x_mozilla_cycle_collect,1905 12:01:18 INFO - PROCESS | 3639 | __end_cc_report 12:01:18 INFO - PROCESS | 3639 | __startTimestamp1467918078754__endTimestamp 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | ------- Summary: start ------- 12:01:18 INFO - PROCESS | 3639 | Number of tests: 14 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:3.10 (2.7%) stddev-sans-first:0.73 12:01:18 INFO - PROCESS | 3639 | Values: 104.0 115.0 113.0 113.0 114.0 114.0 113.0 114.0 113.0 113.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:135.50 stddev:25.21 (18.6%) stddev-sans-first:26.22 12:01:18 INFO - PROCESS | 3639 | Values: 154.0 127.0 126.0 202.0 122.0 122.0 144.0 124.0 153.0 125.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 12:01:18 INFO - PROCESS | 3639 | Values: 162.0 162.0 161.0 163.0 162.0 160.0 160.0 160.0 160.0 161.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.50 stddev:19.20 (25.4%) stddev-sans-first:20.05 12:01:18 INFO - PROCESS | 3639 | Values: 75.0 75.0 79.0 133.0 76.0 79.0 74.0 75.0 104.0 76.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:85.50 stddev:18.69 (21.9%) stddev-sans-first:19.36 12:01:18 INFO - PROCESS | 3639 | Values: 86.0 88.0 121.0 85.0 84.0 85.0 128.0 87.0 86.0 124.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:01:18 INFO - PROCESS | 3639 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:01:18 INFO - PROCESS | 3639 | Values: 146.0 147.0 147.0 147.0 146.0 145.0 146.0 147.0 146.0 146.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:01:18 INFO - PROCESS | 3639 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 12:01:18 INFO - PROCESS | 3639 | Values: 63.0 64.0 63.0 63.0 64.0 65.0 64.0 64.0 65.0 64.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 12:01:18 INFO - PROCESS | 3639 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 68.0 66.0 65.0 65.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.50 stddev:3.95 (4.8%) stddev-sans-first:3.44 12:01:18 INFO - PROCESS | 3639 | Values: 88.0 85.0 79.0 79.0 87.0 78.0 78.0 79.0 79.0 84.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:137.00 stddev:14.76 (10.8%) stddev-sans-first:15.66 12:01:18 INFO - PROCESS | 3639 | Values: 138.0 129.0 144.0 136.0 138.0 124.0 131.0 133.0 177.0 131.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:168.50 stddev:3.06 (1.8%) stddev-sans-first:3.24 12:01:18 INFO - PROCESS | 3639 | Values: 168.0 166.0 167.0 172.0 165.0 172.0 166.0 174.0 167.0 169.0 12:01:18 INFO - PROCESS | 3639 | 12:01:18 INFO - PROCESS | 3639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 12:01:18 INFO - PROCESS | 3639 | Values: 67.0 66.0 67.0 66.0 70.0 66.0 67.0 67.0 68.0 66.0 12:01:18 INFO - PROCESS | 3639 | -------- Summary: end -------- 12:01:18 INFO - PROCESS | 3639 | 12:01:19 INFO - TEST-INFO | 3639: exit 0 12:01:19 INFO - TEST-OK | kraken | took 63285ms 12:01:19 INFO - SUITE-END | took 1183s 12:01:19 INFO - Completed test suite (00:19:43) 12:01:19 INFO - javascript benchmark 12:01:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.615157726342, 2598.4673142005886, 2602.7787638050763, 2605.752453516915, 2628.1721257803797, 4541.250693635546, 4598.517155698653, 4652.069586082785, 4694.765261736912, 4699.365585645941, 4671.836485723001, 4703.553162449562, 4711.340412342275, 4728.078024785168, 4734.644901632383, 4099.323611604082, 4263.786810659462, 4347.2826983547675, 4376.168527979689, 4431.512533621315, 4347.978260108695, 4388.956110438902, 4396.032872768002, 4402.581754733295, 4435.556444355571, 4179.477565304337, 4204.789760511978, 4266.935995960063, 4280.379344994958, 4340.08858139791, 4285.678574106923, 4292.978535107304, 4309.418228539138, 4350.58669426404, 4352.064306174188, 4331.740095594275, 4350.086481838817, 4356.6514678825615, 4397.670174736875, 4402.339649052636, 4558.544145585448, 4654.4647365553055, 4709.788059537329, 4716.646251531115, 4772.475027746945, 5038.269450929594, 5046.798128074873, 5108.055009823194, 5110.080185566597, 5121.078205922932, 5119.104156772587, 5128.743562821881, 5129.102407078746, 5140.794368225266, 5148.433672296044, 4549.954500455019, 4662.487126416091, 4686.250199967989, 4727.456342520585, 4735.195016847076, 5161.380634323905, 5182.689038657692, 5189.506996835295, 5192.402873669576, 5196.8960620787375, 4767.856964291077, 4922.4339200992345, 4925.2119660854805, 4962.03240368132, 4968.22992436173, 4917.754112294371, 4964.429090654621, 4966.006798640286, 4967.453580106186, 4979.825706100269, 4933.45731969483, 4936.925946110811, 4940.184869496493, 4947.628927830355, 4986.351774269394, 4849.539293767087, 4875.317455556225, 4929.2359684248995, 4938.25926111079, 4982.227754698028, 4166.0626359068965, 4173.97913010433, 4201.831926722958, 4240.872773816791, 4244.129953359554, 3660.5058317127377, 3672.192117734094, 3674.6876515496483, 3675.0628589709454, 3701.7408781385584, 4161.188568229166, 4220.91558168841, 4226.344916537942, 4256.59562341577, 4259.850905218303, 4977.228529577921, 5005.849824505271, 5022.547970682656, 5037.219231019198, 5043.193089105725, 4225.873223803291, 4274.722143060691, 4275.059486912936, 4285.250081235834, 4321.632661223768, 4351.934720979188, 4458.108378324348, 4498.707584007029, 4499.775011249424, 4505.05393867285, 4689.577937985598, 4690.085433340534, 4717.363155974037, 4762.571368576845, 4769.3084502746215, 5056.443791182894, 5067.594592432671, 5068.721220332917, 5068.974655126701, 5113.8721531962, 4520.163769702615, 4597.609203217764, 4705.0, 4714.057188562233, 4761.714297142183, 4893.168161412639, 4917.459079501181, 4932.926006109839, 4938.30863679078, 4994.400671919393, 4947.109520286383, 4980.9501904981935, 4983.800647974041, 4986.9251961221335, 5027.798888044437, 4806.735629540409, 4808.35087263229, 4849.175640141114, 4892.217245240744, 4959.156943319716, 4853.053654537332, 4867.269909513601, 4872.074305881871, 4901.289313049517, 4911.582515486224, 4792.113459010095, 4806.4953179917, 4808.855734327975, 4812.085703716282, 4853.927191092207, 4769.117713223065, 4788.688735232199, 4810.4708482067645, 4837.177679794373, 4935.087008903364, 4746.881327966828, 4749.24012158053, 4749.548792864673, 4754.714717116845, 4801.279808028824], "value": 4588.184972808212, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.8034178208517, 571.7770069672827, 572.3989810698765, 580.4079838564663, 592.342499825194, 27611.447771044568, 40081.59918400815, 41689.16621667565, 41750.164996700085, 45314.32028519567, 41881.37177942333, 42469.150616987645, 42508.57491425085, 42532.78733606335, 42643.57356426443, 7795.376369890423, 7927.40544459165, 7929.841403171962, 7940.205979402042, 7943.523388596674, 7656.387489000895, 7733.574653394061, 7740.303372696456, 7743.728969486069, 7749.147593764681, 7738.458307918448, 7783.727569535039, 7790.143084260727, 7790.610469476532, 7803.726869559567, 7700.884486732675, 7734.690612375498, 7743.651535680936, 7748.147703752583, 7752.457327987043, 7722.1891701371105, 7780.649870755829, 7780.883286750646, 7785.0, 7787.649555769947, 39220.80389598062, 39486.80256598699, 39556.208875822325, 39558.20883582341, 39612.60387396118, 3046.771492138076, 3186.7291280241207, 3625.274945010982, 3628.3468975584383, 3691.335559599271, 28472.145835624964, 28798.568021479696, 30745.0, 31432.214194645087, 32612.836935815405, 3536.929261414783, 3592.8742494012586, 3613.476045973345, 3614.0784100054316, 3629.872954446582, 271361.0, 275078.0, 276437.0, 276780.0, 276985.0, 58273.708631456575, 58748.0, 59077.40922590719, 59106.0, 59208.7039564808, 34339.4849077264, 35270.118247043516, 35307.64692353095, 37345.813270933475, 37392.626073739455, 15183.772243416357, 15312.846871531143, 15328.616784580474, 15342.539723808304, 15353.0, 11547.422628868522, 11662.067034637379, 11665.76668466626, 11671.0, 11672.358020308964, 19834.404967850987, 19977.101030453665, 19994.300199492947, 20016.49958751043, 20035.49911252201, 7179.533330333512, 7214.74748383804, 7415.0, 7455.962720186473, 7676.424268179909, 786.3080489169495, 825.69449303758, 926.6154545863391, 968.3512046928574, 1032.4682788363998, 28620.856895715388, 28900.42199156005, 28944.855275723487, 29372.85313573461, 29406.411871762444, 822.8313195794848, 964.5322018820866, 972.6401231544232, 1002.774375765447, 1035.9223058270659, 14572.708545829024, 14988.0, 15094.698106038037, 15285.465008724641, 15342.23288835576, 370621.0, 371203.0, 375124.0, 377953.0, 379008.0, 49901.25148122781, 50364.244536331986, 50537.49462505328, 50574.49425505772, 50607.0, 1064.6646306413454, 1108.7893300273083, 1132.3715337987496, 1171.2562522798085, 1222.022382094321, 26883.193504194904, 29608.407831843673, 30283.0, 30404.0, 30849.383012339178, 42783.572164279205, 43257.3511397323, 43302.133957321304, 43471.0, 43489.34765978449, 281263.0, 281729.0, 282995.0, 283280.0, 283672.0, 25896.35259118462, 26793.598096028185, 26801.927922882867, 26806.59790103189, 26873.328166795985, 42377.36433953555, 42571.14857702766, 42976.57023429726, 43856.34215486834, 43958.0, 36260.0, 36767.81616091902, 36905.07737306589, 37179.44230836486, 37653.62346376501, 36253.818730906176, 36657.0, 36790.0, 37468.62531374651, 37864.81067594644, 35563.288734224654, 36579.634203657624, 36763.26473470462, 37067.814660926524, 37372.62627373692, 31733.5239971396, 32622.0, 32789.67210327866, 32932.83533582317, 33470.4979425304, 25422.491550169263, 25445.618315724907, 25699.0, 25794.226173214833, 26172.214833555023], "value": 17732.742408521193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7194216374355, 373.2683939478622, 374.6178897524525, 374.9981250093749, 385.70493572417104, 12959.416826242817, 13885.652858678526, 17455.91272043638, 17463.301467941266, 17464.214110365032, 15947.601309967256, 16986.32054717813, 17145.742813857803, 17158.571035724082, 17163.82836171638, 4968.2547617857335, 5136.845894623168, 5181.481851814826, 5183.352080989876, 5185.092608793465, 3801.923961520768, 5054.039732450841, 5725.885482290351, 6057.242844644419, 6066.545009124311, 6071.726772295236, 6082.057281121433, 6106.175666285039, 6106.389361063881, 6110.08348747687, 5114.462981386957, 5397.676139431646, 5401.351837779453, 5455.454454554552, 5463.726813659301, 4720.834770783006, 5276.841694749163, 5290.470952904679, 5293.3647962244395, 5296.073187192264, 11828.822567661406, 12205.816912746315, 12248.387580620933, 12323.260604363677, 12338.938305308417, 2028.5942811437624, 2135.327371877869, 2315.6526521021815, 2379.4884099918427, 2419.2742177346727, 9021.323400744905, 9100.817983640356, 9510.4293742375, 9560.56977436017, 10687.358758474516, 1687.0753712858962, 1713.5459103337625, 1736.4443378119006, 1782.1267578886252, 1831.075306969985, 48247.0, 66708.46519774687, 70037.64981175112, 70713.64643176751, 71437.28562714359, 9490.715278541655, 9747.415155090575, 9973.60105595768, 10116.743165036949, 10740.462976851126, 13460.596182114552, 13540.119892206974, 13540.390682419315, 13593.388297526635, 13594.048416610742, 7099.4736131731925, 7118.252583478764, 7185.928140718526, 7194.496385253086, 7413.555186688708, 6825.249222585511, 7040.964795175992, 7186.317299856505, 7285.817854553678, 7411.925880741232, 4184.205001049791, 4234.618884300427, 4306.461692288464, 4310.073334233155, 4369.9126017479475, 1756.1219390304848, 1786.8302511261409, 1800.5498625343664, 1816.6094289727507, 1839.7332386804105, 825.4345773145415, 905.2757793764962, 916.1113719692021, 917.2891009467583, 948.6015873333216, 16545.338186472407, 17128.40050598223, 17171.0, 17507.38724144649, 17618.471445856645, 831.0894908833154, 841.869510225916, 856.148132608059, 858.0926759907359, 858.6307887608264, 9151.816963660689, 9602.615895364246, 9799.804003919882, 10407.895921040845, 10494.108000819862, 379842.0, 382136.0, 385108.0, 386786.0, 394912.0, 83937.0, 86572.0, 86681.0, 86959.0, 86984.13015869887, 947.4930911962067, 952.8665986761858, 958.5590628310915, 961.3030552849128, 968.7239136845965, 14866.331015104563, 15124.924375378052, 16322.836771632607, 16421.26104325284, 16581.75127373066, 35846.0, 39501.802490987364, 39547.40678889761, 41158.08998145171, 41445.1710965785, 52464.21303680524, 52513.21230181627, 53052.20421693601, 53057.0, 53119.73440132775, 7040.0, 7074.00963865049, 7168.2831716827895, 7236.710531578678, 7387.556746595222, 9232.499912891595, 11236.325820450798, 11307.491162897853, 11670.124740644316, 11737.589184378847, 9708.2718796092, 9871.0, 9941.403515789076, 10093.5457904393, 10135.037171468994, 9798.608055677692, 9807.0, 9982.301238913496, 10113.443760593238, 10237.43694096802, 10152.746181345525, 10220.591176352862, 10227.642032529124, 10277.434741089312, 10376.118029967538, 7120.857582848417, 7155.212926577969, 7164.426845852424, 7215.350618444155, 7496.25037496246, 7353.264673532604, 8549.0, 9552.188064014637, 10024.649137280161, 10110.0], "value": 8117.845424521392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.2244041373112, 1371.259519859276, 1416.9291535423229, 1518.817741870975, 1717.914104294785, 6706.6981985810635, 7511.136219334778, 7754.883676744853, 7782.299593036626, 7976.641051152697, 7710.0, 7832.7650170494835, 7837.098733645633, 7854.136045035041, 7856.607169641509, 2179.803817656407, 2207.8012978831903, 2210.8673479591193, 2213.0373287619855, 2213.347062616532, 2188.518525924294, 2208.977910220893, 2244.708187935574, 2246.921357752479, 2249.876256805875, 2194.3965409512352, 2195.5938151441956, 2200.1749343996003, 2204.0742887987003, 2235.0277629231337, 2166.9891650541726, 2173.793489618484, 2176.68438076478, 2177.858439201455, 2179.7384313882276, 2146.388279340396, 2184.486645638274, 2184.584928863527, 2187.1798075721604, 2187.89060546972, 7686.769396918102, 7796.454248202628, 7847.6860925562905, 7861.48900321483, 7882.80292992674, 4572.154151481986, 4682.41469816273, 4682.531746825324, 4683.367745354401, 4689.20283551797, 2802.8598570071617, 2876.4103358811394, 2905.8547072646493, 2913.1843083936533, 2916.8979085732108, 943.5329511891657, 950.0974074629061, 963.9951800241024, 965.5413678502655, 967.8741763570761, 10475.47622618866, 10557.313774604627, 10557.524911379007, 10578.894211057868, 10587.788244235073, 3844.154286057063, 3939.8424063037733, 4006.2988976928923, 4034.8789536313957, 4056.634902858757, 8362.8327433451, 8410.705625303084, 8418.200270974248, 8424.789380265542, 8433.156684331641, 4583.656225783079, 4589.449266088091, 4593.816247350135, 4598.218302888517, 4602.976985115053, 3633.855335569287, 3658.725595580342, 4006.0157938768234, 4262.978685106555, 4276.3157894737315, 3475.7740746851373, 3571.321448924696, 3583.104223944014, 3608.6752192302292, 3631.0, 1070.9196810239264, 1072.0565902006185, 1074.5164675895721, 1102.20090434436, 1105.795427845851, 768.611851015245, 792.2631952284431, 799.7760627024443, 811.1037303779357, 820.5363969357413, 4740.478547359788, 4799.520047995173, 4801.255805350106, 4911.140550403665, 5021.121303771825, 403.1051066632072, 406.43302592882765, 414.52122798168165, 414.97925103744694, 431.93305037719205, 3261.6901394367496, 3272.869085236564, 3312.5528053712924, 3382.340443613472, 3423.554937858112, 9235.584398702074, 9711.805763884682, 9725.416475011521, 9739.610415583298, 9758.658446954323, 8869.512176830336, 9570.808583828424, 9605.327627066039, 9622.615095396106, 9634.277429192838, 7058.894116588255, 7318.597477138702, 7352.852942941111, 7369.373603243785, 7393.445491588152, 4915.5330243626795, 5246.3179786629025, 5291.3385826771655, 5297.8145764898045, 5325.0, 9084.727458176265, 9209.585568649562, 9243.676471323472, 9259.305552083486, 9260.0, 7869.331106855752, 8891.955540222258, 9272.536373181449, 9392.577334019848, 9468.195203407511, 5628.831135065954, 6686.431653309329, 6721.227058888095, 6882.105326307548, 6890.552114112566, 7624.809379765328, 7631.236876312324, 7669.233076692286, 7673.769786906401, 7702.653380597774, 6565.606063636197, 6759.526833121831, 6859.039734437282, 6924.203716572659, 7005.019297298484, 6556.541042127005, 6568.343165683394, 6591.274959754519, 6663.500237482305, 6733.192016957996, 5453.0, 5613.46672066153, 5786.739596718242, 5824.737886795189, 5831.125331200354, 4083.7549747015273, 4200.600942910419, 4203.117345357509, 4218.957810421856, 4269.850555230552, 4051.39229115635, 4201.285781417228, 4206.558311377384, 4243.172581346607, 4275.0594869128745], "value": 3977.498707293273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.6457992089808, 290.925813917451, 292.8199157518126, 296.09542846603625, 309.47698389721364, 4850.757462126893, 4877.878053048676, 4915.3610030696, 4916.164252077147, 4918.704877707336, 4764.26153946138, 4770.379850619423, 4812.518748125186, 4819.469858315591, 4820.3733514643045, 3535.133892196409, 3637.909052273688, 3662.194317250214, 3752.1932784451337, 3842.750221235625, 3770.7549009314307, 3795.35478968576, 3796.164843734388, 3799.8720716398766, 3800.619938006205, 3541.238633693755, 3710.684591809699, 3723.590405055442, 3753.2976257094847, 3756.7182461315374, 3653.433717773736, 3781.0925377909102, 3782.6028267032116, 3794.5067141271734, 3800.4869342638667, 3362.6301106878223, 3362.7646064775477, 3363.562736844219, 3367.1582104473882, 3379.5437615921783, 4687.742174180418, 4706.74112923789, 4708.293755936603, 4716.080364328957, 4719.882002949919, 4225.894352641178, 4319.654427645813, 4324.502682191525, 4334.934975975331, 4338.566143385668, 4967.975160124212, 4979.203327467588, 5001.599872010231, 5052.848414547533, 5053.469385714484, 3679.6872265857432, 3680.5031320771623, 3684.5762737285286, 3691.446283057536, 3695.2978934002454, 4980.975095124538, 5210.895782084337, 5224.555912747383, 5233.241180028913, 5247.842564723026, 3608.4767708682093, 3613.7713177519768, 3621.4386770050683, 3626.220362622049, 3637.0725465006785, 3663.102539877747, 3666.9915773162593, 3668.248009158116, 3670.50448189491, 3672.338978983755, 4213.5154457237195, 4228.957710422918, 4229.851955181553, 4233.238017156879, 4236.279832428495, 4754.738489383117, 5014.0, 5023.171176755867, 5023.949760502422, 5055.772490237948, 1323.4772264955482, 1324.8012798080172, 1334.7063645997864, 1335.065454182057, 1337.224409842289, 871.1984973824098, 871.7733389318822, 911.7674992876774, 930.2046750028763, 930.8789857318505, 4301.978490107529, 4308.827646894152, 4311.956880431218, 4330.501992270866, 4341.479022517318, 5094.133997220481, 5110.693358398508, 5116.258142569307, 5122.078025955364, 5123.769430375642, 4195.391668208093, 4303.289957157097, 4304.569543045671, 4310.870673879788, 4311.9784401077795, 2688.3332333953076, 2688.986555067212, 2717.687465941442, 2732.221316924667, 2748.491529067129, 4726.550977657117, 4752.239641657318, 4766.189747742892, 4769.403824521934, 4799.952000480021, 5106.4382917879, 5157.638965272395, 5194.92207616886, 5219.191025390995, 5237.266782650432, 4712.69367491112, 4723.50403207672, 4743.478217396084, 4749.453812811502, 4765.11845308619, 5030.673006254582, 5058.595312375075, 5070.138076527073, 5106.340439357149, 5123.948760512496, 4810.95189048105, 4974.154393753143, 4976.825811096594, 4980.775865086152, 5014.122528557561, 4688.156131896155, 4705.835295764632, 4707.905841883075, 4728.38530990969, 4733.124371991193, 3745.906352341104, 3777.8299976500575, 3778.6599206071587, 3781.0925377909653, 3787.6780473660046, 4874.2201247800185, 5064.7467626619255, 5094.395265491358, 5100.526244771358, 5119.104156772624, 4902.3872015998, 4910.337104490848, 4915.139850526215, 4918.655694101379, 4925.310456536016, 4914.149793120053, 4921.0, 4972.428170760409, 4982.451930287738, 4988.032120888066, 4692.577668009895, 4840.249761287007, 4906.582940450102, 4922.803087876445, 4924.113659541317, 4738.241881298975, 4863.2461968394955, 5033.094043072282, 5046.1673823818655, 5060.1903695408555, 4934.481879402754, 4939.777710003131, 4960.156773348467, 5004.549590536869, 5016.974915125401], "value": 3774.7621432586957, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.5067945643486, 633.5976654824185, 674.9122614060173, 731.9597422141784, 760.6691089376122, 12764.297963611998, 13333.466661333547, 13731.931340343297, 14007.859921400783, 14034.228117453536, 13179.341032948361, 13210.669733256673, 13308.733825323488, 13327.26700031498, 13330.000249981242, 625.4902254662459, 748.2293237964905, 777.607308309303, 798.4650284309497, 799.0810567846993, 802.4022103532876, 803.0203152154362, 805.2350267246111, 805.4844899264475, 806.1253539909176, 806.5967016491754, 808.0384342632278, 808.4138999225573, 808.7048227397016, 808.8058865872207, 646.6734299178931, 664.8537321789198, 665.1652176518487, 665.930077341877, 808.030363563723, 582.0919365789382, 602.7167231401278, 606.5147881694627, 606.9666168360739, 607.0590584593906, 13262.933685331607, 13299.401526931215, 13308.134971226838, 13311.0, 13315.201087934754, 12793.87206127936, 13273.734525309439, 13340.132891362031, 13368.86631133686, 13579.370475542899, 11924.70188245292, 11953.52185912571, 12141.15011949164, 12179.208351457128, 12636.178648387917, 4118.91762164758, 4168.499780026386, 4203.453551038346, 4249.447571815645, 4253.468316460442, 62588.37411625871, 62850.37149628536, 62897.05654415142, 64732.85037921437, 65375.3462465374, 10316.48417579118, 10509.720447006172, 10668.093212077061, 10699.25105242641, 10978.670639880816, 19191.232350705814, 19205.711914321295, 19214.80785192158, 19216.903915480332, 19232.519187020436, 6612.107365505692, 6614.404703576605, 6909.930900691029, 7059.364657180879, 7066.893996590055, 3499.2651543175707, 3589.1565482111682, 3611.2777444511203, 3640.4903313536124, 3730.0488375464083, 2856.2716507290925, 2964.925876853096, 2969.287371030937, 2990.5065664165604, 3002.8048176868433, 489.4175930642524, 506.7415618034755, 515.1962937816943, 516.2282387830218, 523.9083160446907, 408.2849053792305, 421.147176966645, 489.3589397888777, 545.1169106048148, 571.1580154003306, 7253.274672532704, 7368.8894666580045, 7453.515521491086, 7581.166071732105, 7591.582462964479, 435.56225992876955, 506.4985664192423, 545.4926917966329, 562.5696342298145, 581.7294957844538, 3400.302937897725, 3409.761316707856, 3452.5511683480986, 3497.7726447780815, 3595.388783906742, 88383.0, 93874.53062734642, 96074.51962740142, 97586.0, 97618.51190744001, 57923.71038144867, 73701.6314918422, 74961.62519187479, 74989.62505187548, 76594.23405765982, 69512.6524367375, 73005.26994730091, 74189.0, 74567.99999999891, 75791.62104189444, 6511.902321465087, 6607.405333520006, 6639.103720997604, 6740.157480314961, 6827.146606674166, 32094.518582221754, 41212.58787412087, 42931.0, 43243.0, 43314.350284745124, 47012.7649361751, 59344.406555933885, 61147.38852611595, 61467.69266153641, 62087.843722782134, 9275.82018225703, 9471.526423678652, 9718.514074296398, 9766.56050477716, 9778.951105244429, 10262.384256944608, 10320.43237621938, 10350.275480716278, 10357.274990750575, 10622.521986510472, 7980.441369104107, 9801.0, 10071.395716257048, 11150.55397784112, 11762.882371176178, 12322.199057061262, 12674.619761407173, 12752.48990040425, 12754.48982040708, 13009.544665936646, 11972.341521216416, 12024.939875300568, 12070.939645301718, 12078.698032549257, 12182.573609923964, 10400.167986561208, 10843.512041957973, 11183.776324473627, 11358.204925655125, 11519.193656444304, 10016.64941727036, 10340.638077667245, 10392.636257730943, 10448.42533660656, 10488.68533943983], "value": 6393.913380558794, "unit": "score"}], "name": "dromaeo_css", "value": 6314.8449211516245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 126.0, 202.0, 122.0, 122.0, 144.0, 124.0, 153.0, 125.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 160.0, 160.0, 160.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 133.0, 76.0, 79.0, 74.0, 75.0, 104.0, 76.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 121.0, 85.0, 84.0, 85.0, 128.0, 87.0, 86.0, 124.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 68.0, 66.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 79.0, 79.0, 87.0, 78.0, 78.0, 79.0, 79.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 129.0, 144.0, 136.0, 138.0, 124.0, 131.0, 133.0, 177.0, 131.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 167.0, 172.0, 165.0, 172.0, 166.0, 174.0, 167.0, 169.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 70.0, 66.0, 67.0, 67.0, 68.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1538.8999999999996, "alertThreshold": 2.0}]} 12:01:19 INFO - Return code: 0 12:01:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:01:20 INFO - # TBPL SUCCESS # 12:01:20 INFO - Running post-action listener: _resource_record_post_action 12:01:20 INFO - ##### 12:01:20 INFO - ##### Finished run-tests step (success) 12:01:20 INFO - ##### 12:01:20 INFO - Running post-run listener: _resource_record_post_run 12:01:20 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7761920; Write bytes: 367267840; Read time: 1408; Write time: 303124 12:01:20 INFO - TinderboxPrint: CPU usage
12.9% 12:01:20 INFO - TinderboxPrint: I/O read bytes / time
7,761,920 / 1,408 12:01:20 INFO - TinderboxPrint: I/O write bytes / time
367,267,840 / 303,124 12:01:20 INFO - TinderboxPrint: CPU idle
8,337.0 (87.0%) 12:01:20 INFO - TinderboxPrint: CPU user
1,199.8 (12.5%) 12:01:20 INFO - TinderboxPrint: Swap in / out
0 / 0 12:01:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 85835776; Read time: 0; Write time: 64080 12:01:20 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5705728; Write bytes: 281432064; Read time: 1260; Write time: 239044 12:01:20 INFO - Running post-run listener: _upload_blobber_files 12:01:20 INFO - Blob upload gear active. 12:01:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:01:20 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 12:01:20 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'] 12:01:20 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 12:01:21 INFO - (blobuploader) - INFO - Open directory for files ... 12:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:01:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:21 INFO - (blobuploader) - INFO - Done attempting. 12:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:01:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:25 INFO - (blobuploader) - INFO - Done attempting. 12:01:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:01:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:01:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:26 INFO - (blobuploader) - INFO - Done attempting. 12:01:26 INFO - (blobuploader) - INFO - Iteration through files over. 12:01:26 INFO - Return code: 0 12:01:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:01:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:01:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a22b9913eef9e8b6ffe1a2a516bb61a152d83cbce6c6e9a9db47b5e5b21820a52b187fb9b0e1d31bc50d921f29a85f954438334377da98aec73c4cfce9504e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d3f5c91701afd6adf2729ca1f54614414abcb53c6b48aa7daf97b0b77f3068f7f5f1ac86435eec55b5eecdb639c3562253ed13d34b60ac3b59dd4d0ccbd9da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00b7e9bb0758a2fef13bf9e1c4940dab07a2ebb659204c2d275e84d7639e3730d7691473162d7417e731fc316cb169bed221fb85c81810eb94e0b1b054004314"} 12:01:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:01:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:01:26 INFO - Contents: 12:01:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a22b9913eef9e8b6ffe1a2a516bb61a152d83cbce6c6e9a9db47b5e5b21820a52b187fb9b0e1d31bc50d921f29a85f954438334377da98aec73c4cfce9504e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d3f5c91701afd6adf2729ca1f54614414abcb53c6b48aa7daf97b0b77f3068f7f5f1ac86435eec55b5eecdb639c3562253ed13d34b60ac3b59dd4d0ccbd9da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00b7e9bb0758a2fef13bf9e1c4940dab07a2ebb659204c2d275e84d7639e3730d7691473162d7417e731fc316cb169bed221fb85c81810eb94e0b1b054004314"} 12:01:26 INFO - Running post-run listener: copy_logs_to_upload_dir 12:01:26 INFO - Copying logs to upload dir... 12:01:26 INFO - mkdir: /builds/slave/test/build/upload/logs 12:01:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.454913 ========= master_lag: 16.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-07 12:01:43.114696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 12:01:43.118393) ========= 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=00204705a9daa57ed339a427000001b9-1467916837.466903-264862612 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/a22b9913eef9e8b6ffe1a2a516bb61a152d83cbce6c6e9a9db47b5e5b21820a52b187fb9b0e1d31bc50d921f29a85f954438334377da98aec73c4cfce9504e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d3f5c91701afd6adf2729ca1f54614414abcb53c6b48aa7daf97b0b77f3068f7f5f1ac86435eec55b5eecdb639c3562253ed13d34b60ac3b59dd4d0ccbd9da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00b7e9bb0758a2fef13bf9e1c4940dab07a2ebb659204c2d275e84d7639e3730d7691473162d7417e731fc316cb169bed221fb85c81810eb94e0b1b054004314"} build_url:https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009198 build_url: 'https://queue.taskcluster.net/v1/task/P3RBbXZ3RIazTP8k647hPA/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/a22b9913eef9e8b6ffe1a2a516bb61a152d83cbce6c6e9a9db47b5e5b21820a52b187fb9b0e1d31bc50d921f29a85f954438334377da98aec73c4cfce9504e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d3f5c91701afd6adf2729ca1f54614414abcb53c6b48aa7daf97b0b77f3068f7f5f1ac86435eec55b5eecdb639c3562253ed13d34b60ac3b59dd4d0ccbd9da5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00b7e9bb0758a2fef13bf9e1c4940dab07a2ebb659204c2d275e84d7639e3730d7691473162d7417e731fc316cb169bed221fb85c81810eb94e0b1b054004314"}' ========= master_lag: 0.81 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 12:01:43.934518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:01:43.934854) ========= 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=00204705a9daa57ed339a427000001b9-1467916837.466903-264862612 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002917 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:01:43.991656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 12:01:43.991950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 12:01:43.995124) ========= ========= Total master_lag: 17.83 =========