builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1476316961.12 results: success (0) buildid: 20161012144547 builduid: bfe8229c097446c2a44a972f6a05e5bd revision: d68def1644c1849141ceaa31bc1b811becfbb8da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.115706) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.116208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.116524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.131313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.131680) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 17:02:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.5M=0s 2016-10-12 17:02:41 (89.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.281958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.282300) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017977 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:41.331877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 17:02:41.332293) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d68def1644c1849141ceaa31bc1b811becfbb8da --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 d68def1644c1849141ceaa31bc1b811becfbb8da --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=82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 17:02:41,865 truncating revision to first 12 chars 2016-10-12 17:02:41,865 Setting DEBUG logging. 2016-10-12 17:02:41,865 attempt 1/10 2016-10-12 17:02:41,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d68def1644c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 17:02:42,610 unpacking tar archive at: fx-team-d68def1644c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.084564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 17:02:42.430292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:42.430626) ========= script_repo_revision: d68def1644c1849141ceaa31bc1b811becfbb8da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:42.431041) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:42.431336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 17:02:42.440078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-12 17:02:42.440369) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:02:43 INFO - MultiFileLogger online at 20161012 17:02:43 in /builds/slave/test 17:02:43 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 17:02:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:02:43 INFO - {'append_to_log': False, 17:02:43 INFO - 'base_work_dir': '/builds/slave/test', 17:02:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:02:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:02:43 INFO - 'branch': 'Fx-Team-Non-PGO', 17:02:43 INFO - 'buildbot_json_path': 'buildprops.json', 17:02:43 INFO - 'config_files': ('talos/linux_config.py',), 17:02:43 INFO - 'default_actions': ('clobber', 17:02:43 INFO - 'read-buildbot-config', 17:02:43 INFO - 'download-and-extract', 17:02:43 INFO - 'populate-webroot', 17:02:43 INFO - 'create-virtualenv', 17:02:43 INFO - 'install', 17:02:43 INFO - 'run-tests'), 17:02:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:02:43 INFO - 'download_minidump_stackwalk': True, 17:02:43 INFO - 'download_symbols': 'ondemand', 17:02:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:02:43 INFO - 'tooltool.py': '/tools/tooltool.py', 17:02:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:02:43 INFO - '/tools/misc-python/virtualenv.py')}, 17:02:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:02:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:02:43 INFO - 'installer_path': 'installer.exe', 17:02:43 INFO - 'log_level': 'info', 17:02:43 INFO - 'log_name': 'talos', 17:02:43 INFO - 'log_to_console': True, 17:02:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:02:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:02:43 INFO - 'opt_config_files': (), 17:02:43 INFO - 'pip_index': False, 17:02:43 INFO - 'sps_profile': False, 17:02:43 INFO - 'sps_profile_interval': 0, 17:02:43 INFO - 'suite': 'dromaeojs', 17:02:43 INFO - 'system_bits': '32', 17:02:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:02:43 INFO - 'title': 'talos-linux64-ix-066', 17:02:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:02:43 INFO - 'use_talos_json': True, 17:02:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:02:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:02:43 INFO - 'work_dir': 'build'} 17:02:43 INFO - [mozharness: 2016-10-13 00:02:43.072469Z] Running clobber step. 17:02:43 INFO - Running pre-action listener: _resource_record_pre_action 17:02:43 INFO - Running main action method: clobber 17:02:43 INFO - rmtree: /builds/slave/test/build 17:02:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:02:44 INFO - Running post-action listener: _resource_record_post_action 17:02:44 INFO - [mozharness: 2016-10-13 00:02:44.059664Z] Finished clobber step (success) 17:02:44 INFO - [mozharness: 2016-10-13 00:02:44.059765Z] Running read-buildbot-config step. 17:02:44 INFO - Running pre-action listener: _resource_record_pre_action 17:02:44 INFO - Running main action method: read_buildbot_config 17:02:44 INFO - Using buildbot properties: 17:02:44 INFO - { 17:02:44 INFO - "project": "", 17:02:44 INFO - "product": "firefox", 17:02:44 INFO - "script_repo_revision": "production", 17:02:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:02:44 INFO - "repository": "", 17:02:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:02:44 INFO - "buildid": "20161012144547", 17:02:44 INFO - "pgo_build": "False", 17:02:44 INFO - "basedir": "/builds/slave/test", 17:02:44 INFO - "buildnumber": 2203, 17:02:44 INFO - "slavename": "talos-linux64-ix-066", 17:02:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:02:44 INFO - "platform": "ubuntu64_hw", 17:02:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:02:44 INFO - "branch": "fx-team", 17:02:44 INFO - "repo_path": "integration/fx-team", 17:02:44 INFO - "revision": "d68def1644c1849141ceaa31bc1b811becfbb8da", 17:02:44 INFO - "stage_platform": "linux64", 17:02:44 INFO - "builduid": "bfe8229c097446c2a44a972f6a05e5bd", 17:02:44 INFO - "slavebuilddir": "test" 17:02:44 INFO - } 17:02:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:02:44 INFO - Running post-action listener: _resource_record_post_action 17:02:44 INFO - [mozharness: 2016-10-13 00:02:44.062223Z] Finished read-buildbot-config step (success) 17:02:44 INFO - [mozharness: 2016-10-13 00:02:44.062311Z] Running download-and-extract step. 17:02:44 INFO - Running pre-action listener: _resource_record_pre_action 17:02:44 INFO - Running main action method: download_and_extract 17:02:44 INFO - mkdir: /builds/slave/test/build/tests 17:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:44 INFO - trying https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:02:44 INFO - Downloading https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:02:44 INFO - Downloaded 1361 bytes. 17:02:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:02:44 INFO - Using the following test package requirements: 17:02:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:02:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:02:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'jsshell-linux-x86_64.zip'], 17:02:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:02:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:02:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:02:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:02:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:02:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:02:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:02:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:02:44 INFO - Fetch https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:02:45 INFO - Http code: 200 17:02:45 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 17:02:45 INFO - x-amz-cf-id: 2kDJUZcut1mAbcw9lUvKlpOaAiEOwBdFTC5zd16Eaze0FWShO9D_fQ== 17:02:45 INFO - x-amz-version-id: xJVkHJZXfiy6KRvhsCxmuCe3tncL1UGA 17:02:45 INFO - Expected file size: 20548528 17:02:45 INFO - Obtained file size: 20548528 17:02:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:02:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:02:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:02:49 INFO - Fetch https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:02:50 INFO - Http code: 200 17:02:50 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 17:02:50 INFO - x-amz-cf-id: 1xsXKXdlcLd1aA7_ZLxlbbsh36WpEByYKzkyAKTqqD-hT818M_2Iuw== 17:02:50 INFO - x-amz-version-id: xJVkHJZXfiy6KRvhsCxmuCe3tncL1UGA 17:02:50 INFO - Expected file size: 20548528 17:02:50 INFO - Obtained file size: 20548528 17:02:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:02:55 INFO - Fetch https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:02:55 INFO - Http code: 200 17:02:55 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 17:02:55 INFO - x-amz-cf-id: YUXFhG7zmNzKUtdOJxInBQjXtk8LkxGm843W6cxqScctSp-fA6MwLw== 17:02:55 INFO - x-amz-version-id: S.FLVR3_VA3x4GFakEBZa2_u0UdzGE1D 17:02:55 INFO - Expected file size: 14409006 17:02:55 INFO - Obtained file size: 14409006 17:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:56 INFO - trying https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:02:56 INFO - Downloading https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:02:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:02:57 INFO - Downloaded 55943696 bytes. 17:02:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:02:57 INFO - mkdir: /builds/slave/test/properties 17:02:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:57 INFO - Contents: 17:02:57 INFO - build_url:https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:02:58 INFO - Running post-action listener: _resource_record_post_action 17:02:58 INFO - Running post-action listener: set_extra_try_arguments 17:02:58 INFO - [mozharness: 2016-10-13 00:02:58.268558Z] Finished download-and-extract step (success) 17:02:58 INFO - [mozharness: 2016-10-13 00:02:58.268857Z] Running populate-webroot step. 17:02:58 INFO - Running pre-action listener: _resource_record_pre_action 17:02:58 INFO - Running main action method: populate_webroot 17:02:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:58 INFO - '--tppagecycles', 17:02:58 INFO - '7'], 17:02:58 INFO - 'tests': ['tsvgm']}}, 17:02:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['damp', 'tps']}, 17:02:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'tests': ['damp', 'tps']}, 17:02:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['dromaeo_dom']}, 17:02:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['basic_compositor_video']}, 17:02:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:02:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore', 17:02:58 INFO - 'tabpaint']}, 17:02:58 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore', 17:02:58 INFO - 'tabpaint']}, 17:02:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore', 17:02:58 INFO - 'tabpaint']}, 17:02:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore', 17:02:58 INFO - 'tabpaint']}, 17:02:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore', 17:02:58 INFO - 'tabpaint']}, 17:02:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore', 17:02:58 INFO - 'tabpaint']}, 17:02:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['tsvgx', 17:02:58 INFO - 'tsvgr_opacity', 17:02:58 INFO - 'tart', 17:02:58 INFO - 'tscrollx', 17:02:58 INFO - 'cart']}, 17:02:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:58 INFO - 'tsvgr_opacity', 17:02:58 INFO - 'tart', 17:02:58 INFO - 'tscrollx', 17:02:58 INFO - 'cart']}, 17:02:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--disable-e10s'], 17:02:58 INFO - 'tests': ['tp5o']}, 17:02:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'tests': ['tp5o']}, 17:02:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--disable-e10s', 17:02:58 INFO - '--xperf_path', 17:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:58 INFO - 'tests': ['tp5n']}, 17:02:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--xperf_path', 17:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:58 INFO - 'tests': ['tp5n']}}, 17:02:58 INFO - 'talos.zip': {'path': '', 17:02:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:58 INFO - Running post-action listener: _resource_record_post_action 17:02:58 INFO - [mozharness: 2016-10-13 00:02:58.291287Z] Finished populate-webroot step (success) 17:02:58 INFO - [mozharness: 2016-10-13 00:02:58.291379Z] Running create-virtualenv step. 17:02:58 INFO - Running pre-action listener: _resource_record_pre_action 17:02:58 INFO - Running main action method: create_virtualenv 17:02:58 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:58 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 17:02:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:58 INFO - Using real prefix '/usr' 17:02:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:03:00 INFO - Installing pip.................done. 17:03:00 INFO - Return code: 0 17:03:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:03:01 INFO - Reading from file tmpfile_stdout 17:03:01 INFO - Output received: 17:03:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:03:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:03:01 INFO - Using env: {'DISPLAY': ':0', 17:03:01 INFO - 'HOME': '/home/cltbld', 17:03:01 INFO - 'LANG': 'en_US.UTF-8', 17:03:01 INFO - 'LANGUAGE': 'en_US:en', 17:03:01 INFO - 'LOGNAME': 'cltbld', 17:03:01 INFO - 'MAIL': '/var/mail/cltbld', 17:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:01 INFO - 'MOZ_NO_REMOTE': '1', 17:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:01 INFO - 'NO_EM_RESTART': '1', 17:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:01 INFO - 'PWD': '/builds/slave/test', 17:03:01 INFO - 'SHELL': '/bin/bash', 17:03:01 INFO - 'SHLVL': '1', 17:03:01 INFO - 'TERM': 'linux', 17:03:01 INFO - 'TMOUT': '86400', 17:03:01 INFO - 'USER': 'cltbld', 17:03:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:01 INFO - '_': '/tools/buildbot/bin/python'} 17:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:01 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 17:03:01 INFO - Cleaning up... 17:03:01 INFO - Return code: 0 17:03:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:03:01 INFO - Using env: {'DISPLAY': ':0', 17:03:01 INFO - 'HOME': '/home/cltbld', 17:03:01 INFO - 'LANG': 'en_US.UTF-8', 17:03:01 INFO - 'LANGUAGE': 'en_US:en', 17:03:01 INFO - 'LOGNAME': 'cltbld', 17:03:01 INFO - 'MAIL': '/var/mail/cltbld', 17:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:01 INFO - 'MOZ_NO_REMOTE': '1', 17:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:01 INFO - 'NO_EM_RESTART': '1', 17:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:01 INFO - 'PWD': '/builds/slave/test', 17:03:01 INFO - 'SHELL': '/bin/bash', 17:03:01 INFO - 'SHLVL': '1', 17:03:01 INFO - 'TERM': 'linux', 17:03:01 INFO - 'TMOUT': '86400', 17:03:01 INFO - 'USER': 'cltbld', 17:03:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:01 INFO - '_': '/tools/buildbot/bin/python'} 17:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:01 INFO - Downloading/unpacking psutil>=3.1.1 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:03 INFO - Installing collected packages: psutil 17:03:03 INFO - Running setup.py install for psutil 17:03:03 INFO - building 'psutil._psutil_linux' extension 17:03:03 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 17:03: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:03:03 INFO - building 'psutil._psutil_posix' extension 17:03:03 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 17:03: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 17:03:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:04 INFO - Successfully installed psutil 17:03:04 INFO - Cleaning up... 17:03:04 INFO - Return code: 0 17:03:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:04 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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:04 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 17:03:04 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 17:03:04 INFO - Using env: {'DISPLAY': ':0', 17:03:04 INFO - 'HOME': '/home/cltbld', 17:03:04 INFO - 'LANG': 'en_US.UTF-8', 17:03:04 INFO - 'LANGUAGE': 'en_US:en', 17:03:04 INFO - 'LOGNAME': 'cltbld', 17:03:04 INFO - 'MAIL': '/var/mail/cltbld', 17:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:04 INFO - 'MOZ_NO_REMOTE': '1', 17:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:04 INFO - 'NO_EM_RESTART': '1', 17:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:04 INFO - 'PWD': '/builds/slave/test', 17:03:04 INFO - 'SHELL': '/bin/bash', 17:03:04 INFO - 'SHLVL': '1', 17:03:04 INFO - 'TERM': 'linux', 17:03:04 INFO - 'TMOUT': '86400', 17:03:04 INFO - 'USER': 'cltbld', 17:03:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:04 INFO - '_': '/tools/buildbot/bin/python'} 17:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:03:06 INFO - Installing collected packages: mozsystemmonitor 17:03:06 INFO - Running setup.py install for mozsystemmonitor 17:03:06 INFO - Successfully installed mozsystemmonitor 17:03:06 INFO - Cleaning up... 17:03:06 INFO - Return code: 0 17:03:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:06 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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:06 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 17:03:06 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 17:03:06 INFO - Using env: {'DISPLAY': ':0', 17:03:06 INFO - 'HOME': '/home/cltbld', 17:03:06 INFO - 'LANG': 'en_US.UTF-8', 17:03:06 INFO - 'LANGUAGE': 'en_US:en', 17:03:06 INFO - 'LOGNAME': 'cltbld', 17:03:06 INFO - 'MAIL': '/var/mail/cltbld', 17:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:06 INFO - 'MOZ_NO_REMOTE': '1', 17:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:06 INFO - 'NO_EM_RESTART': '1', 17:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:06 INFO - 'PWD': '/builds/slave/test', 17:03:06 INFO - 'SHELL': '/bin/bash', 17:03:06 INFO - 'SHLVL': '1', 17:03:06 INFO - 'TERM': 'linux', 17:03:06 INFO - 'TMOUT': '86400', 17:03:06 INFO - 'USER': 'cltbld', 17:03:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:06 INFO - '_': '/tools/buildbot/bin/python'} 17:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:06 INFO - Downloading/unpacking jsonschema==2.5.1 17:03:06 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 17:03:06 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 17:03:06 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 17:03:06 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 17:03:06 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 17:03:06 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 17:03:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:09 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:09 INFO - warning: no files found matching '*.txt' 17:03:09 INFO - no previously-included directories found matching 'build' 17:03:09 INFO - no previously-included directories found matching 'dist' 17:03:09 INFO - no previously-included directories found matching '.git*' 17:03:09 INFO - Installing collected packages: jsonschema, functools32 17:03:09 INFO - Running setup.py install for functools32 17:03:10 INFO - warning: no files found matching '*.txt' 17:03:10 INFO - no previously-included directories found matching 'build' 17:03:10 INFO - no previously-included directories found matching 'dist' 17:03:10 INFO - no previously-included directories found matching '.git*' 17:03:10 INFO - Successfully installed jsonschema functools32 17:03:10 INFO - Cleaning up... 17:03:10 INFO - Return code: 0 17:03:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:03:10 INFO - Using env: {'DISPLAY': ':0', 17:03:10 INFO - 'HOME': '/home/cltbld', 17:03:10 INFO - 'LANG': 'en_US.UTF-8', 17:03:10 INFO - 'LANGUAGE': 'en_US:en', 17:03:10 INFO - 'LOGNAME': 'cltbld', 17:03:10 INFO - 'MAIL': '/var/mail/cltbld', 17:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:10 INFO - 'MOZ_NO_REMOTE': '1', 17:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:10 INFO - 'NO_EM_RESTART': '1', 17:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:10 INFO - 'PWD': '/builds/slave/test', 17:03:10 INFO - 'SHELL': '/bin/bash', 17:03:10 INFO - 'SHLVL': '1', 17:03:10 INFO - 'TERM': 'linux', 17:03:10 INFO - 'TMOUT': '86400', 17:03:10 INFO - 'USER': 'cltbld', 17:03:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:10 INFO - '_': '/tools/buildbot/bin/python'} 17:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:03:10 INFO - Cleaning up... 17:03:10 INFO - Return code: 0 17:03:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:10 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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:10 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 17:03:10 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 17:03:10 INFO - Using env: {'DISPLAY': ':0', 17:03:10 INFO - 'HOME': '/home/cltbld', 17:03:10 INFO - 'LANG': 'en_US.UTF-8', 17:03:10 INFO - 'LANGUAGE': 'en_US:en', 17:03:10 INFO - 'LOGNAME': 'cltbld', 17:03:10 INFO - 'MAIL': '/var/mail/cltbld', 17:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:10 INFO - 'MOZ_NO_REMOTE': '1', 17:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:10 INFO - 'NO_EM_RESTART': '1', 17:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:10 INFO - 'PWD': '/builds/slave/test', 17:03:10 INFO - 'SHELL': '/bin/bash', 17:03:10 INFO - 'SHLVL': '1', 17:03:10 INFO - 'TERM': 'linux', 17:03:10 INFO - 'TMOUT': '86400', 17:03:10 INFO - 'USER': 'cltbld', 17:03:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:10 INFO - '_': '/tools/buildbot/bin/python'} 17:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:12 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:12 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 17:03:13 INFO - Downloading docopt-0.6.1.tar.gz 17:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:03:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:03:13 INFO - Running setup.py install for blobuploader 17:03:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:03:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:03:13 INFO - Running setup.py install for requests 17:03:13 INFO - Running setup.py install for docopt 17:03:13 INFO - Successfully installed blobuploader requests docopt 17:03:13 INFO - Cleaning up... 17:03:13 INFO - Return code: 0 17:03:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:13 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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:13 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 17:03:13 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 17:03:13 INFO - Using env: {'DISPLAY': ':0', 17:03:13 INFO - 'HOME': '/home/cltbld', 17:03:13 INFO - 'LANG': 'en_US.UTF-8', 17:03:13 INFO - 'LANGUAGE': 'en_US:en', 17:03:13 INFO - 'LOGNAME': 'cltbld', 17:03:13 INFO - 'MAIL': '/var/mail/cltbld', 17:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:13 INFO - 'MOZ_NO_REMOTE': '1', 17:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:13 INFO - 'NO_EM_RESTART': '1', 17:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:13 INFO - 'PWD': '/builds/slave/test', 17:03:13 INFO - 'SHELL': '/bin/bash', 17:03:13 INFO - 'SHLVL': '1', 17:03:13 INFO - 'TERM': 'linux', 17:03:13 INFO - 'TMOUT': '86400', 17:03:13 INFO - 'USER': 'cltbld', 17:03:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:13 INFO - '_': '/tools/buildbot/bin/python'} 17:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:14 INFO - Running setup.py (path:/tmp/pip-ySo9EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:14 INFO - Running setup.py (path:/tmp/pip-5FEJ41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:14 INFO - Running setup.py (path:/tmp/pip-NcCJ8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:14 INFO - Running setup.py (path:/tmp/pip-o_Vp7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:14 INFO - Running setup.py (path:/tmp/pip-9uf_k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:14 INFO - Running setup.py (path:/tmp/pip-BHIJqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:14 INFO - Running setup.py (path:/tmp/pip-88KPiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:14 INFO - Running setup.py (path:/tmp/pip-BdOywi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:14 INFO - Running setup.py (path:/tmp/pip-P71o2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:14 INFO - Running setup.py (path:/tmp/pip-gS91MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:14 INFO - Running setup.py (path:/tmp/pip-RnC0Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:14 INFO - Running setup.py (path:/tmp/pip-VYydGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:14 INFO - Running setup.py (path:/tmp/pip-T4EJ0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:14 INFO - Running setup.py (path:/tmp/pip-1ekfRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:15 INFO - Running setup.py (path:/tmp/pip-11QkOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:15 INFO - Running setup.py (path:/tmp/pip-WRTLtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:15 INFO - Running setup.py (path:/tmp/pip-iJRvwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:03:15 INFO - Running setup.py install for manifestparser 17:03:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:03:15 INFO - Running setup.py install for mozcrash 17:03:15 INFO - Running setup.py install for mozdebug 17:03:15 INFO - Running setup.py install for mozdevice 17:03:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:03:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:03:15 INFO - Running setup.py install for mozfile 17:03:15 INFO - Running setup.py install for mozhttpd 17:03:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:03:15 INFO - Running setup.py install for mozinfo 17:03:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:03:15 INFO - Running setup.py install for mozInstall 17:03:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Running setup.py install for mozleak 17:03:16 INFO - Running setup.py install for mozlog 17:03:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Running setup.py install for moznetwork 17:03:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Running setup.py install for mozprocess 17:03:16 INFO - Running setup.py install for mozprofile 17:03:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Running setup.py install for mozrunner 17:03:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:03:16 INFO - Running setup.py install for mozscreenshot 17:03:16 INFO - Running setup.py install for moztest 17:03:16 INFO - Running setup.py install for mozversion 17:03:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:03:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:03:17 INFO - Cleaning up... 17:03:17 INFO - Return code: 0 17:03:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:17 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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:17 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 17:03:17 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 17:03:17 INFO - Using env: {'DISPLAY': ':0', 17:03:17 INFO - 'HOME': '/home/cltbld', 17:03:17 INFO - 'LANG': 'en_US.UTF-8', 17:03:17 INFO - 'LANGUAGE': 'en_US:en', 17:03:17 INFO - 'LOGNAME': 'cltbld', 17:03:17 INFO - 'MAIL': '/var/mail/cltbld', 17:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:17 INFO - 'MOZ_NO_REMOTE': '1', 17:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:17 INFO - 'NO_EM_RESTART': '1', 17:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:17 INFO - 'PWD': '/builds/slave/test', 17:03:17 INFO - 'SHELL': '/bin/bash', 17:03:17 INFO - 'SHLVL': '1', 17:03:17 INFO - 'TERM': 'linux', 17:03:17 INFO - 'TMOUT': '86400', 17:03:17 INFO - 'USER': 'cltbld', 17:03:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:17 INFO - '_': '/tools/buildbot/bin/python'} 17:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:17 INFO - Running setup.py (path:/tmp/pip-sXYrFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:17 INFO - Running setup.py (path:/tmp/pip-JusZI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:17 INFO - Running setup.py (path:/tmp/pip-uXOneM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:17 INFO - Running setup.py (path:/tmp/pip-cz_ITf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:17 INFO - Running setup.py (path:/tmp/pip-S50f_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:17 INFO - Running setup.py (path:/tmp/pip-WHshLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:17 INFO - Running setup.py (path:/tmp/pip-AuzmBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:17 INFO - Running setup.py (path:/tmp/pip-c2pIIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:17 INFO - Running setup.py (path:/tmp/pip-8ufCyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:17 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)) 17:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:17 INFO - Running setup.py (path:/tmp/pip-IvsYXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:18 INFO - Running setup.py (path:/tmp/pip-Z0xqtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:18 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)) 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:18 INFO - Running setup.py (path:/tmp/pip-33_5mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:18 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)) 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:18 INFO - Running setup.py (path:/tmp/pip-0YbEX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:18 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)) 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:18 INFO - Running setup.py (path:/tmp/pip-bX0El0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:18 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)) 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:18 INFO - Running setup.py (path:/tmp/pip-OA_5oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:18 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)) 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:18 INFO - Running setup.py (path:/tmp/pip-ozjVFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:18 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)) 17:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:18 INFO - Running setup.py (path:/tmp/pip-_oEoGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:18 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)) 17:03:18 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)) 17:03:18 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)) 17:03:18 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)) 17:03:18 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)) 17:03:18 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)) 17:03:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:20 INFO - Downloading blessings-1.6.tar.gz 17:03:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:03:20 INFO - Installing collected packages: blessings 17:03:20 INFO - Running setup.py install for blessings 17:03:20 INFO - Successfully installed blessings 17:03:20 INFO - Cleaning up... 17:03:20 INFO - Return code: 0 17:03:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:20 INFO - Reading from file tmpfile_stdout 17:03:20 INFO - Current package versions: 17:03:20 INFO - argparse == 1.2.1 17:03:20 INFO - blessings == 1.6 17:03:20 INFO - blobuploader == 1.2.4 17:03:20 INFO - docopt == 0.6.1 17:03:20 INFO - functools32 == 3.2.3-2 17:03:20 INFO - jsonschema == 2.5.1 17:03:20 INFO - manifestparser == 1.1 17:03:20 INFO - mozInstall == 1.12 17:03:20 INFO - mozcrash == 0.17 17:03:20 INFO - mozdebug == 0.1 17:03:20 INFO - mozdevice == 0.48 17:03:20 INFO - mozfile == 1.2 17:03:20 INFO - mozhttpd == 0.7 17:03:20 INFO - mozinfo == 0.9 17:03:20 INFO - mozleak == 0.1 17:03:20 INFO - mozlog == 3.4 17:03:20 INFO - moznetwork == 0.27 17:03:20 INFO - mozprocess == 0.23 17:03:20 INFO - mozprofile == 0.28 17:03:20 INFO - mozrunner == 6.12 17:03:20 INFO - mozscreenshot == 0.1 17:03:20 INFO - mozsystemmonitor == 0.3 17:03:20 INFO - moztest == 0.7 17:03:20 INFO - mozversion == 1.4 17:03:20 INFO - psutil == 3.1.1 17:03:20 INFO - requests == 1.2.3 17:03:20 INFO - wsgiref == 0.1.2 17:03:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:20 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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:20 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 17:03:20 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 17:03:20 INFO - Using env: {'DISPLAY': ':0', 17:03:20 INFO - 'HOME': '/home/cltbld', 17:03:20 INFO - 'LANG': 'en_US.UTF-8', 17:03:20 INFO - 'LANGUAGE': 'en_US:en', 17:03:20 INFO - 'LOGNAME': 'cltbld', 17:03:20 INFO - 'MAIL': '/var/mail/cltbld', 17:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:20 INFO - 'MOZ_NO_REMOTE': '1', 17:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:20 INFO - 'NO_EM_RESTART': '1', 17:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:20 INFO - 'PWD': '/builds/slave/test', 17:03:20 INFO - 'SHELL': '/bin/bash', 17:03:20 INFO - 'SHLVL': '1', 17:03:20 INFO - 'TERM': 'linux', 17:03:20 INFO - 'TMOUT': '86400', 17:03:20 INFO - 'USER': 'cltbld', 17:03:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:20 INFO - '_': '/tools/buildbot/bin/python'} 17:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 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)) 17:03:21 INFO - Cleaning up... 17:03:21 INFO - Return code: 0 17:03:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:21 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 0x7fe54cfe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', '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 17:03:21 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 17:03:21 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 17:03:21 INFO - Using env: {'DISPLAY': ':0', 17:03:21 INFO - 'HOME': '/home/cltbld', 17:03:21 INFO - 'LANG': 'en_US.UTF-8', 17:03:21 INFO - 'LANGUAGE': 'en_US:en', 17:03:21 INFO - 'LOGNAME': 'cltbld', 17:03:21 INFO - 'MAIL': '/var/mail/cltbld', 17:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:21 INFO - 'MOZ_NO_REMOTE': '1', 17:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:21 INFO - 'NO_EM_RESTART': '1', 17:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:21 INFO - 'PWD': '/builds/slave/test', 17:03:21 INFO - 'SHELL': '/bin/bash', 17:03:21 INFO - 'SHLVL': '1', 17:03:21 INFO - 'TERM': 'linux', 17:03:21 INFO - 'TMOUT': '86400', 17:03:21 INFO - 'USER': 'cltbld', 17:03:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:21 INFO - '_': '/tools/buildbot/bin/python'} 17:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:03:21 INFO - Cleaning up... 17:03:21 INFO - Return code: 0 17:03:21 INFO - Running post-action listener: _resource_record_post_action 17:03:21 INFO - Running post-action listener: _start_resource_monitoring 17:03:21 INFO - Starting resource monitoring. 17:03:21 INFO - [mozharness: 2016-10-13 00:03:21.424722Z] Finished create-virtualenv step (success) 17:03:21 INFO - [mozharness: 2016-10-13 00:03:21.425229Z] Running install step. 17:03:21 INFO - Running pre-action listener: _resource_record_pre_action 17:03:21 INFO - Running main action method: install 17:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:21 INFO - Reading from file tmpfile_stdout 17:03:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:03:21 INFO - Reading from file tmpfile_stdout 17:03:21 INFO - Output received: 17:03:21 INFO - Usage: mozinstall [options] installer 17:03:21 INFO - Options: 17:03:21 INFO - -h, --help show this help message and exit 17:03:21 INFO - -d DEST, --destination=DEST 17:03:21 INFO - Directory to install application into. [default: 17:03:21 INFO - "/builds/slave/test"] 17:03:21 INFO - --app=APP Application being installed. [default: firefox] 17:03:21 INFO - mkdir: /builds/slave/test/build/application 17:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:03:37 INFO - Reading from file tmpfile_stdout 17:03:37 INFO - Output received: 17:03:37 INFO - /builds/slave/test/build/application/firefox/firefox 17:03:37 INFO - Running post-action listener: _resource_record_post_action 17:03:37 INFO - [mozharness: 2016-10-13 00:03:37.904594Z] Finished install step (success) 17:03:37 INFO - [mozharness: 2016-10-13 00:03:37.904839Z] Running run-tests step. 17:03:37 INFO - Running pre-action listener: _resource_record_pre_action 17:03:37 INFO - Running main action method: run_tests 17:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:03:37 INFO - Python 2.7.3 17:03:37 INFO - Return code: 0 17:03:37 INFO - grabbing minidump binary from tooltool 17:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:37 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 0x1a8bf60>, '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 0x1a8cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:03:37 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 17:03:37 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 17:03:37 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 17:03:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:03:37 INFO - Return code: 0 17:03:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:03:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:03:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:03:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:03:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:03:37 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/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:03:37 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/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 17:03:37 INFO - Using env: {'DISPLAY': ':0', 17:03:37 INFO - 'HOME': '/home/cltbld', 17:03:37 INFO - 'LANG': 'en_US.UTF-8', 17:03:37 INFO - 'LANGUAGE': 'en_US:en', 17:03:37 INFO - 'LOGNAME': 'cltbld', 17:03:37 INFO - 'MAIL': '/var/mail/cltbld', 17:03:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:03:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:37 INFO - 'MOZ_NO_REMOTE': '1', 17:03:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:37 INFO - 'NO_EM_RESTART': '1', 17:03:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:37 INFO - 'PWD': '/builds/slave/test', 17:03:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:03:37 INFO - 'SHELL': '/bin/bash', 17:03:37 INFO - 'SHLVL': '1', 17:03:37 INFO - 'TERM': 'linux', 17:03:37 INFO - 'TMOUT': '86400', 17:03:37 INFO - 'USER': 'cltbld', 17:03:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672', 17:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:37 INFO - '_': '/tools/buildbot/bin/python'} 17:03:37 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/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:03:38 INFO - mozversion application_buildid: 20161012144547 17:03:38 INFO - mozversion application_changeset: d68def1644c1849141ceaa31bc1b811becfbb8da 17:03:38 INFO - mozversion application_display_name: Nightly 17:03:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:03:38 INFO - mozversion application_name: Firefox 17:03:38 INFO - mozversion application_remotingname: firefox 17:03:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:03:38 INFO - mozversion application_vendor: Mozilla 17:03:38 INFO - mozversion application_version: 52.0a1 17:03:38 INFO - mozversion platform_buildid: 20161012144547 17:03:38 INFO - mozversion platform_changeset: d68def1644c1849141ceaa31bc1b811becfbb8da 17:03:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:03:38 INFO - mozversion platform_version: 52.0a1 17:03:38 INFO - using testdate: 1476317018 17:03:38 INFO - actual date: 1476317018 17:03:38 INFO - starting webserver on 'localhost:58269' 17:03:38 INFO - SUITE-START | Running 2 tests 17:03:38 INFO - TEST-START | dromaeo_css 17:03:38 INFO - operating with platform_type : linux_ 17:03:38 INFO - Initialising browser for dromaeo_css test... 17:03:38 INFO - TEST-INFO | started process 23711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOnS0UF/profile http://localhost:58269/getInfo.html) 17:03:42 INFO - PROCESS | 23711 | __metrics Screen width/height:1600/1200 17:03:42 INFO - PROCESS | 23711 | colorDepth:24 17:03:42 INFO - PROCESS | 23711 | Browser inner width/height: 1024/697 17:03:42 INFO - PROCESS | 23711 | __metrics 17:03:43 INFO - PROCESS | 23711 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:03:43 INFO - PROCESS | 23711 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:03:43 INFO - PROCESS | 23711 | console.error: PushService: 17:03:43 INFO - PROCESS | 23711 | stateChangeProcessEnqueue: Error transitioning state 17:03:43 INFO - PROCESS | 23711 | UnknownError 17:03:44 INFO - TEST-INFO | 23711: exit 0 17:03:44 INFO - Browser initialized. 17:03:44 INFO - Running cycle 1/1 for dromaeo_css test... 17:03:44 INFO - TEST-INFO | started process 23793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOnS0UF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:56 INFO - PROCESS | 23793 | RSS: Main: 175030272 17:03:56 INFO - PROCESS | 23793 | 17:04:48 INFO - PROCESS | 23793 | 1476317088521 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] 17:07:02 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:58269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58269/tests/dromaeo/cssquery-ext.html) 17:07:03 INFO - PROCESS | 23793 | RSS: Main: 320147456 17:07:03 INFO - PROCESS | 23793 | 17:10:06 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:58269/tests/dromaeo/cssquery-ext.html (next: http://localhost:58269/tests/dromaeo/cssquery-jquery.html) 17:10:06 INFO - PROCESS | 23793 | RSS: Main: 276217856 17:10:06 INFO - PROCESS | 23793 | 17:13:09 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:58269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58269/tests/dromaeo/cssquery-mootools.html) 17:13:10 INFO - PROCESS | 23793 | RSS: Main: 219258880 17:13:10 INFO - PROCESS | 23793 | 17:16:12 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:58269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58269/tests/dromaeo/cssquery-prototype.html) 17:16:12 INFO - PROCESS | 23793 | RSS: Main: 219586560 17:16:12 INFO - PROCESS | 23793 | 17:19:15 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:58269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58269/tests/dromaeo/cssquery-yui.html) 17:19:16 INFO - PROCESS | 23793 | RSS: Main: 221040640 17:19:16 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | Cycle 1(1): loaded http://localhost:58269/tests/dromaeo/cssquery-yui.html (next: http://localhost:58269/tests/dromaeo/cssquery-dojo.html) 17:22:19 INFO - PROCESS | 23793 | RSS: Main: 314241024 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | __start_tp_report 17:22:19 INFO - PROCESS | 23793 | _x_x_mozilla_page_load 17:22:19 INFO - PROCESS | 23793 | _x_x_mozilla_page_load_details 17:22:19 INFO - PROCESS | 23793 | |i|pagename|runs| 17:22:19 INFO - PROCESS | 23793 | |0;dojo.html;2570.4216551275963;2589.0808762889187;2621.344663834042;2634.262406526172;2648.4173481834;4518.412606361177;4594.40272764541;4731.1956967315555;4743.383360163179;4748.952510474895;4619.1454580902555;4626.028534007863;4631.258998560231;4635.675502714811;4640.3967484227005;4234.110836724291;4256.787160641971;4262.232798096342;4288.742675439468;4290.2706539888295;4335.371371151197;4346.217680817452;4373.453318335208;4374.168907907503;4376.081022985161;4326.870193894189;4342.869713908588;4368.213721530124;4369.847055353063;4383.517813040563;4388.605025547684;4421.734695918255;4424.579664931826;4452.487963884146;4475.239209334389;4195.496540415139;4200.4539409876525;4242.3212286034395;4342.131573685244;4346.6522678185665;4550.072101447501;4566.26939689648;4573;4592.288195329729;4667.649926255511;4883.8290659826735;4930.260460930853;4935.9753201234125;4937.037277730844;4975.676581022258;4931.80272789088;4959.900801983977;4967.776450059756;4980.053789779967;5016.2224855147515;4594.74728889911;4618.076384723069;4628.074385122922;4694.037722266995;4715.056988602293;5013.373328333958;5029.899402012013;5073.010762901199;5076.111680455905;5136.948630513722;4809.831655892097;4815.061063092663;4821.590164836029;4821.662483626183;4877.195262781673;4791.688540244873;4834.6374021948495;4835.29888166221;4945.579625731853;4953.90092198154;4933.703977761345;4952.504749525018;5007.048660754518;5019.14674505335;5024.874378140576;4913.336699545587;4926.236433352836;4929.802807887644;4936.062148191832;4993.026359859865;4073.653739432122;4114.855980040744;4163.146554956226;4175.039740859619;4180.456540649696;3626.401643728808;3664.2121943782213;3670.926581468356;3671.2290419011774;3724.3854763964187;4365.06151177492;4384.517703052662;4387.605115539617;4394.978025109918;4450.955490445119;5059.367579052619;5072.923906141411;5084.593232541388;5085.6948583084395;5139.331886854685;4246.617804397557;4293.914121717548;4299.914001719948;4344.304911214191;4367;4491.46102467706;4497.190505709003;4516.932246016312;4549.567791059844;4554.111948170075;4786.234202527578;4795;4799.088173247072;4802.183628783046;4847.903041939212;4846.466888642317;4912.017596480647;4918.262260660929;5060.240963855451;5069.645124841373;4724.6692731508465;4770.260609605517;4788.257820037899;4795.328653988375;4832.299316599003;4968.2795994579865;4973.328600638867;4976.247917029286;4976.975115124401;5037.949620503748;4782.450018247946;5048.545630893237;5056.82301119459;5060.974695126501;5077.695338279715;4668.206404911241;4834.516548345137;4885.1450996076255;4885.5358740919555;4982.725950072636;4880.316755654282;4910.680805747615;4910.779014944264;4916.237983112624;4974.776135073858;4851.975740121276;4869.513048695102;4873.829415970424;4878.780454879468;4935.75321233944;4775.6179505638775;4825.083234185494;4882.292067650242;4915.066137433876;4930.753462326941;4847.61219102478;4848.490908454562;4852.708837469763;4896.706197628154;4906.215005599087 17:22:19 INFO - PROCESS | 23793 | |1;ext.html;564.7402194990304;565.4091474409242;569.3310360326615;570.3156212544947;584.9970750146251;26682.86658566707;27406.86296568519;29189.124326270194;37652.43521347182;38413.622092906946;38195.42706859393;38631.99999999993;38644.80677596615;38663.42004869922;38686.419703704465;7452.70189192433;7613.467057305963;7616.086069671619;7620.276073772982;7625.084989801232;7393.297636724503;7480.401567874557;7481.812954676149;7495.512791668524;7534.698612055511;7541.547507149561;7580.355669768049;7584.582847943361;7588.165301816795;7591.051118610174;7529.397648188132;7561.281678240586;7563.243675632448;7568.621568921587;7578.469507134503;7540.472166948316;7581.09026916768;7585.696572137108;7594.962025189894;7605.695772169107;34815.4777678335;35114;35213.647863521546;35263.1184220394;35325.11687207815;2872.4975018518535;3114.5951026366656;3459.567554055743;3467.497212904115;3533.1697051193205;27551.44897102067;27652.446951060865;27790.444191116065;28972.710272897213;29023.709762902312;3035.696430356969;3103.5810165627577;3106.1923899785993;3177.126290270171;3256.674332566748;233296;233603;234131;234501;234567.8271608648;30778;31513;50742.74628626833;51095;51189;33245.50131748026;33494;33542.329153416795;33582.16044598856;33584;12801;12980.480780768852;12984.350782460839;13025.088243822842;13028.153170044106;10464.372137671764;10664.360138391721;10673.519691613896;10711.357318560911;10713.946430267955;7802.960985195038;7821.061472623208;7860.960695196602;7916.129225785159;7923.247291507298;3090.5827713258873;3097.530765542607;3106.130283520618;3123.297258116951;3175.555422240888;812.4921923797626;948.1653001442094;977.6431602465049;999.7250756042147;1001.2140469731372;26520.52117913288;27033.72966270312;27173.456530869273;27529.86235068852;27547.31131721683;930.6137952749533;949.3829011142674;961.6105477281712;961.6153538584482;983.3313346924017;13520.661983450493;14429.85570144306;14441.205733684537;14481;14787.408503659733;354331;356096;357799;358282;358350;48103.5189648106;48494.3328116957;48856.75571622119;48863;48894.51105488971;1137.2266858536275;1157.9594714184964;1158.8609366876028;1183.2545496337252;1186.4364426897328;25751.871240643675;26298.73701262963;26693.19920402391;26968.460630787667;27295.86352068227;41495.377569335884;41744.3738343919;41863;41870.06909516427;41882;319944;324126;324205;324626;324697;24794.25617231486;25123.371915701522;25294.11470598594;25401.872990635668;25494.617580735932;40517.797411012754;40554.79722601486;41463.58536414597;41487.377689335284;42199.367009495494;34839.825800870836;34887;35049.123771905906;35366;35514.467282991296;34453.31093378068;34503.30993380068;34854.82572587121;34884.30231395409;35127.29745405129;25153.38637533105;31665.20836979094;32021.35957280795;34740.652593474755;36479;29370.853145734134;31880.68119318777;31981.200469988435;31991.360172796878;32151.517727233644;24367.51264974726;24392.146274880295;24876.50246995086;25275.87362063178;25317.367065823502 17:22:19 INFO - PROCESS | 23793 | |2;jquery.html;347.7339835026204;349.41821866592124;369.99260014799705;373.74585282008235;380.7410960546829;12206.81689774653;12569.685757856047;12755.071449985013;12826.422810973505;17182.226799794007;16142.354305827783;16319.265633046512;16723.247453864577;16831.663366732657;16862.915685421587;4786.497417771127;4881.219004959189;4994.325766021595;5025.899482010358;5057.974710126463;3562.3765840977853;4955.182394904837;5044.495550444963;5044.873878153057;5049.4698056704065;3724.664780169784;5556.416576259495;5815.82552523425;5826.193879897245;5915.467607915287;5731.541476681856;5905.468507834294;5920.141579470953;5920.822375328747;5932.9406705932815;5259.316288882421;5284.5772338212855;5284.9735751320995;5285.101532739443;5287.233351164098;15969.680606387807;19627.411177664693;20434;20468.795312046837;20612.5877482451;1769.2834402067056;1853.629274145163;1886.76415448069;1907.1131923655428;1980.1584326661255;8810.559472026373;8895.4662720237;9159.679411220575;9517;12866.87133128666;1629.5926018495377;1659.5436255029963;1679.3450554283838;1732.7574139620463;1734.7831521059868;45509.544904550865;59801.7009914952;62415;62560.687196564184;64967.350326496606;9138.223251023604;9208.953955230316;9625.374350667184;9900.158486528726;10031.849522257173;14085.295735213198;14105.435782568582;14113.57659270203;14132.081414708011;14133.646658833406;6741.1236539249585;6914.9308506915295;7013.754518591825;7071.717131314793;7072.115985501812;5901.439363260483;5911.527077833763;6026.276846778414;6426.710798014101;6814.420774234246;4162.042730172077;4266.679999000087;4297.09760950204;4297.484301883794;4342.69601127918;1817.1277786662213;1864.4779461750732;1867.5237814357524;1889.8960557169487;1913.4929243750416;803.5901690138072;819.4878201124297;832.2426591801552;838.2497664590157;868.1188593577524;16526.338946442007;16848.326066957183;17261.827381726274;17755.289788408576;17759.112044397727;820.1634332980445;823.6828820903995;827.3505298340893;844.8817165596821;864.4726716702806;9383.5308234588;9497.287703422271;9862.260330475243;9873.91526036223;9901;359174;371733;371791;372197;372761;46959.29561056587;49703;68602;74990;77819;812.5490352854105;862.4307956748515;881.6737807011318;885.93798434109;887.2325438495784;10778.461076945965;13641.931790340985;14925.477608283658;16143.273552689921;16253.756193656867;32278;32921.50617740688;34380.14049648779;36889;38512.61487385202;43071;47079.85280680649;48083.75958120187;48244;51260.23109653433;5159.690418574897;7061.293870612898;7245.746398876014;7708.8458230836195;8065.395095367753;9974.451405172495;11331.546738130712;11387.373694446886;11804.409779511161;12143.02855771554;9419.246460283024;9818.803623927624;10060.295779295378;10580.41807700584;10602.522886469973;8235.50586964784;8403.83192336162;9093.590788414405;9562.904370956201;10877.238593298393;8504.574771261536;8594.78513037154;9154.496502692416;9208.815823683623;9306.255499560155;6741.494387920828;7124;7197.352238298578;7255.673494692646;7391.40868730511;7447.292507211806;8836.779080523038;9039.322050846082;9398.107179817905;9879.110880020833 17:22:19 INFO - PROCESS | 23793 | |3;mootools.html;1319.3535167767798;1362.2031111799597;1395.539471974248;1601.6876709041726;1620.7649890765847;6577.50668699847;6813.659317034153;7229.963850180755;7749.263819937111;7797.415193860462;7369.336759691627;7667.769966900988;7699.153093159762;7835.098963619185;7846.176151504095;2135.540858715376;2145.6459684152137;2174.2716190076344;2177.0747432341273;2177.7822217778253;1804.0979510244877;2066.1838573763353;2082.2607974169177;2180.5202855371795;2193.0679461228992;1849.574597842497;2119.8198153157;2208.5914105890383;2211.3255457085584;2230.3309007297826;2107.6838474228834;2122.299641118435;2122.490602255463;2125.224293133003;2131.904064317094;2075.6575165097893;2119.4383488375593;2124.3414541492034;2125.0968338456096;2127.8936053197276;7861.921380786233;7901.20987901211;7917.247861453153;7923.5245885246495;7927.484713493662;4489.753063581502;4633.884152896171;4642.442906851165;4644.489106198315;4644.698094623873;2718.877650505732;2788.5538313869683;2846.9288267793263;2847.700991395894;2866;870.2298465857698;872.4067634008871;895.2211575928918;904.8099899021213;908.5457271364318;10093.39439633617;10098.192144628412;10103.949480252551;10166.796664066751;10179.18566514677;3808.5239345081864;3890.6109389060866;4098.836046558164;4118.5057793065025;4179.1432756284885;8716.520591367409;8727.825443491094;8731.781705457288;8732.8690069649;8739.344549158839;4516.774161291923;4518.796654150571;4521.276595744665;4524.773761311922;4545.36364908913;4045.130296986103;4177.227212965611;4178.8537401190815;4179.975905903073;4183.644390226865;3553.573571171424;3572.285542891432;3640.1445660269815;3654.488371627974;3657.2868290683596;1037.0821822686976;1149.827525871126;1165.877582853805;1183.2486371154207;1195.5277665322149;604.1089393145076;606.5996442348029;660.9655888534428;693.639307560066;755.720383458124;4950.2822090796635;5002.424721157114;5191.196753753006;5212.244224587489;5248.2390053442805;811.939104567148;827.4042689263721;839.3159574946399;860.2429861721645;869.9782505437288;3535.1869070113503;3591.856325746941;3727.2918145552258;3784.9810750946067;3785.5078839750654;9246.167844893991;9557.044295570387;9638.180754635934;9676.951615241878;9695.66065187715;9565.091316324939;9570.56932438042;9591.568379422943;9606.039396060478;9612.567434465465;7261.673224704901;7421.925780742124;7436.330730234196;7438.5536867788105;7441.181470038291;4862.781174847211;4909.189983652657;4929.580985616263;5357.598180136583;5493.670379777226;8573.699920502753;8657.22085012352;8663.566821659018;8715.603209117544;8767.649294028422;8671.393002489765;8683.86974195375;8754.912450875665;8806;8899.866502002345;6372.235331760218;6387.840303992437;6506.772262970773;6524.380183882524;6526.379993900572;7205.423566114593;7264.382527485011;7265.564066156047;7266.89099663516;7268.0914885639295;6469.611823290617;6580.0097688373935;6603.075569420381;6676.165479315086;6786.151731033621;6538.83652908662;6580.8354791130605;6589.17635295588;6611.900821487586;6637.568558043712;5973.701314934323;6047.334793172659;6053.576249662481;6067.089936509559;6073.240844894388;4408.336488075081;4462.821487140478;4508.346289788028;4529.456465224194;4572.382728331632;4448.4439445069365;4449.7330160190495;4462.7768611568645;4701.9529804701515;4808.326834243278 17:22:19 INFO - PROCESS | 23793 | |4;prototype.html;291.17597199924217;295.4386665335863;301.79025577223825;303.96200474940633;304.9070033639739;4773.6897101688455;4784.282357646351;4789.856304310872;4815.349927759756;4815.903681926359;4682.180618391785;4741.525847415265;4766.903612169203;4769.8807529811775;4780.211265141247;3784.12965018046;3784.7888675623813;3786.678132358753;3788.6590206881374;3792.5448946126435;3491.1970246843243;3776.9811150944206;3780.2439512097553;3800.448934904437;3817.2174704185577;3698.981505092471;3715.7398982071268;3731.1045349116152;3731.496248006525;3742.9438558421643;3682.5949145593963;3714.1614900624363;3715.1269451678836;3721.292954338694;3721.832517536717;3081.383723255358;3150.84245787712;3159.526071089332;3266.6243382011135;3278.246003419203;4580.656450766206;4595.402597662316;4603.930941035887;4608.953910460886;4622.8150873965005;4184.4141820145205;4193.454850869368;4198.13938142683;4206.705530612859;4225.985763416788;4622.560856718606;4718.952810471886;4918.000019987805;4962.702237865739;4983.206045823501;3527.876524321662;3529.100079479742;3541.451075083366;3542.220711443478;3570.6072332043454;5162.586993040548;5185.196294574347;5185.948140518622;5202.661826981272;5207.6875387476875;3545.290941811648;3613.4100995561867;3616.385214513539;3619.167591453928;3629.6914762245506;3627.7279204059273;3663.7176988054503;3673.687736542424;3680.582975554431;3681.668649821529;4163.875083747493;4165.958340416618;4166.312558427886;4183.560726123713;4193.20329137469;4932.630052746058;4950.950490495049;4952.876178095505;4970.304157417964;4976.303317535548;1202.6211743300832;1258.4777317413354;1259.1123258103016;1261.3188878005774;1265.7405231927432;804.2399932064143;813.9186081391932;819.1644522587047;823.6211342782267;832.4422636833336;3929.2141571685206;3949.565547789741;3974.20515896816;3981.3032719274593;3988.720789544704;4514.864554063383;4520.570545798144;4541.72749635023;4546.909061818745;4553.702194874445;3960.940585891214;3971.5035620547433;3972.940405893914;3981.243563722883;3995.5405128410025;2420.649005894171;2439.8536087834786;2522.7638457155863;2698.46030793842;2714.8914043438435;4659.673822832437;4706.1999460091865;4777.4473296178185;4860.781264843091;4888.82889098887;5183.533481986564;5203.895922081537;5218.808100597758;5236.973815130977;5240;4835.153848076643;4835.178019736653;4842.854714358575;4847.927281090787;4859.343988561499;4989.355641510006;5077.826358525921;5090.1495162709;5132.2814805926455;5139.331886854835;4988.401391833003;5016.347874776256;5030.195168772979;5030.320906677552;5030.949690503195;4859.708417494961;4872.1717308057005;4876.805182730253;4881.194602890625;4912.287718280901;3525.894223173309;3592.964070359263;3622.6558476944647;3629.909252268714;3644.034330902366;5106.591472682102;5122.206058061007;5124.30821839047;5124.721536817085;5141.665791723526;5020.221865610836;5043.218301163325;5050.3434553507805;5052.671576347526;5052.877791327578;4765.475797662185;5005.273180752634;5027.069992051483;5036.143855544639;5054.721990290423;4925.778339974638;4936.259561065869;4937.876553086202;4941.135301322326;4965.006998600222;5046.747662616928;5067.315912351785;5071.377159309133;5073.985202959349;5076.213186956028;4783.736894470838;4877.097736918681;4889.462159162418;4901.828436004723;4911.68074075184 17:22:19 INFO - PROCESS | 23793 | |5;yui.html;631.9368063193681;681.1349586025744;714.3499415531867;734.3904559215849;736.3152268390395;12940.2235865848;14203.289835508234;14338.426462941496;14347.13917164971;14386.1368317901;12466.002719782418;12649.494020239203;12669.23984560927;12693.809592856114;12699.999999999976;606.6633018674634;621.6891554222889;742.2874040920696;743.4015617427982;769.8806684963839;770.8535378278137;770.8650986077442;772.6677528662673;773.1186447449884;773.3156156801243;813.2843098073716;819.8278361544083;821.843849668561;821.8520666280067;822.0382152881114;633.0377825704926;646.9838254043663;767.6852490478877;776.3866545429104;785.081454697999;585.5315747402061;585.5871610514577;586.085706298172;586.237890742038;586.4692453329743;12408.56570020045;12409.813852792215;12424.130310878241;12437.564685236064;12440.315782631951;12351.19717218378;12483.126181167321;12680.80978785319;12900.419481123372;13178.406971686298;11018.228723989325;11273.661790146309;11493.712657183554;11601;12291.754164916742;3807.9428808567895;3829.9808500957597;3830.1382189007527;3865.4781604483314;3903.668188204006;56621;57028.71485642545;57577.424225757626;58310;65788.3421165787;9573.90426095744;9791.167750741124;9908.653197138066;9954.800903982024;10025.398476091312;16689.491098471604;16698;16881.577960551083;17009.149542522824;17144.65710685804;6152;6160.537959652955;6238.906416403757;6242.692086644645;6314.116023756677;3409.2499650076943;3417.8974630761118;3424.143964008998;3460.8596811342504;3476.478528220787;2698.743619356158;2770.48745981994;2791.9302017449727;2797.1328888044363;2799.1882354117483;442.8627125591077;444.5643269595814;447.7604481602327;453.17295934918906;457.97939092740904;442.4403975984616;450.5359479735877;473.46734923211386;523.9703981675949;524.3864678326368;6599.241087274929;6797.150356205474;6880.311968803079;6977.720891164398;7184.9640751795905;433.10347580508045;473.15777915310804;515.7060475528988;558.8463172627479;559.6781850436015;3431.4852772083887;3517.3668739627115;3580.516630254934;3759.812009399519;3871.7676939383728;100595;102738;103102;103341.48329258306;103804.48097759463;90275;91455.54272228596;91665.54167229254;91852;92186;78455.21544784593;79200;80018;80608.19391806124;80883.19116808756;6643.243054132481;7504.287092726182;8040.276375126266;8230.83538329242;8411.45325553837;29328.542779085314;37115.25769484649;39149.91051163331;40237.19525609413;43100.353494696974;60696.696516517135;62091.37908620856;63103;63323;63510.04734929072;10299.330543514647;10329.690109296733;10413.375197487872;10626;10821.51303191374;12126.090543209471;12510.249385036926;12726.809097863354;12817.615471535868;13027.674308142372;11024.5038973248;11160.665180044612;11599.710007249887;11608.129390295593;11670.94164529172;11666.824997625212;11756.764864702487;11960.521579136737;12359;12509.499620015098;10968.062879315745;11357.318560886373;11466.656000320003;11503.137264705349;12025.098117641386;9795.412275263507;10137;10229.232807539316;10358.844617330595;10579.576816927236;8108.554029528433;8806.383553151474;9192.448453092837;9521.761955951157;9581.473018984023 17:22:19 INFO - PROCESS | 23793 | __end_tp_report 17:22:19 INFO - PROCESS | 23793 | __start_cc_report 17:22:19 INFO - PROCESS | 23793 | _x_x_mozilla_cycle_collect,1414 17:22:19 INFO - PROCESS | 23793 | __end_cc_report 17:22:19 INFO - PROCESS | 23793 | __startTimestamp1476318139534__endTimestamp 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | ------- Summary: start ------- 17:22:19 INFO - PROCESS | 23793 | Number of tests: 6 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | [#0] dojo.html Cycles:165 Average:4620.95 Median:4791.69 stddev:481.15 (10.0%) stddev-sans-first:454.95 17:22:19 INFO - PROCESS | 23793 | Values: 2570.4 2589.1 2621.3 2634.3 2648.4 4518.4 4594.4 4731.2 4743.4 4749.0 4619.1 4626.0 4631.3 4635.7 4640.4 4234.1 4256.8 4262.2 4288.7 4290.3 4335.4 4346.2 4373.5 4374.2 4376.1 4326.9 4342.9 4368.2 4369.8 4383.5 4388.6 4421.7 4424.6 4452.5 4475.2 4195.5 4200.5 4242.3 4342.1 4346.7 4550.1 4566.3 4573.0 4592.3 4667.6 4883.8 4930.3 4936.0 4937.0 4975.7 4931.8 4959.9 4967.8 4980.1 5016.2 4594.7 4618.1 4628.1 4694.0 4715.1 5013.4 5029.9 5073.0 5076.1 5136.9 4809.8 4815.1 4821.6 4821.7 4877.2 4791.7 4834.6 4835.3 4945.6 4953.9 4933.7 4952.5 5007.0 5019.1 5024.9 4913.3 4926.2 4929.8 4936.1 4993.0 4073.7 4114.9 4163.1 4175.0 4180.5 3626.4 3664.2 3670.9 3671.2 3724.4 4365.1 4384.5 4387.6 4395.0 4451.0 5059.4 5072.9 5084.6 5085.7 5139.3 4246.6 4293.9 4299.9 4344.3 4367.0 4491.5 4497.2 4516.9 4549.6 4554.1 4786.2 4795.0 4799.1 4802.2 4847.9 4846.5 4912.0 4918.3 5060.2 5069.6 4724.7 4770.3 4788.3 4795.3 4832.3 4968.3 4973.3 4976.2 4977.0 5037.9 4782.5 5048.5 5056.8 5061.0 5077.7 4668.2 4834.5 4885.1 4885.5 4982.7 4880.3 4910.7 4910.8 4916.2 4974.8 4852.0 4869.5 4873.8 4878.8 4935.8 4775.6 4825.1 4882.3 4915.1 4930.8 4847.6 4848.5 4852.7 4896.7 4906.2 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | [#1] ext.html Cycles:180 Average:44180.16 Median:34778.07 stddev:81549.63 (234.5%) stddev-sans-first:81712.64 17:22:19 INFO - PROCESS | 23793 | Values: 564.7 565.4 569.3 570.3 585.0 26682.9 27406.9 29189.1 37652.4 38413.6 38195.4 38632.0 38644.8 38663.4 38686.4 7452.7 7613.5 7616.1 7620.3 7625.1 7393.3 7480.4 7481.8 7495.5 7534.7 7541.5 7580.4 7584.6 7588.2 7591.1 7529.4 7561.3 7563.2 7568.6 7578.5 7540.5 7581.1 7585.7 7595.0 7605.7 34815.5 35114.0 35213.6 35263.1 35325.1 2872.5 3114.6 3459.6 3467.5 3533.2 27551.4 27652.4 27790.4 28972.7 29023.7 3035.7 3103.6 3106.2 3177.1 3256.7 233296.0 233603.0 234131.0 234501.0 234567.8 30778.0 31513.0 50742.7 51095.0 51189.0 33245.5 33494.0 33542.3 33582.2 33584.0 12801.0 12980.5 12984.4 13025.1 13028.2 10464.4 10664.4 10673.5 10711.4 10713.9 7803.0 7821.1 7861.0 7916.1 7923.2 3090.6 3097.5 3106.1 3123.3 3175.6 812.5 948.2 977.6 999.7 1001.2 26520.5 27033.7 27173.5 27529.9 27547.3 930.6 949.4 961.6 961.6 983.3 13520.7 14429.9 14441.2 14481.0 14787.4 354331.0 356096.0 357799.0 358282.0 358350.0 48103.5 48494.3 48856.8 48863.0 48894.5 1137.2 1158.0 1158.9 1183.3 1186.4 25751.9 26298.7 26693.2 26968.5 27295.9 41495.4 41744.4 41863.0 41870.1 41882.0 319944.0 324126.0 324205.0 324626.0 324697.0 24794.3 25123.4 25294.1 25401.9 25494.6 40517.8 40554.8 41463.6 41487.4 42199.4 34839.8 34887.0 35049.1 35366.0 35514.5 34453.3 34503.3 34854.8 34884.3 35127.3 25153.4 31665.2 32021.4 34740.7 36479.0 29370.9 31880.7 31981.2 31991.4 32151.5 24367.5 24392.1 24876.5 25275.9 25317.4 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | [#2] jquery.html Cycles:180 Average:22605.44 Median:5047.17 stddev:60744.70 (1203.5%) stddev-sans-first:60892.12 17:22:19 INFO - PROCESS | 23793 | Values: 347.7 349.4 370.0 373.7 380.7 12206.8 12569.7 12755.1 12826.4 17182.2 16142.4 16319.3 16723.2 16831.7 16862.9 4786.5 4881.2 4994.3 5025.9 5058.0 3562.4 4955.2 5044.5 5044.9 5049.5 3724.7 5556.4 5815.8 5826.2 5915.5 5731.5 5905.5 5920.1 5920.8 5932.9 5259.3 5284.6 5285.0 5285.1 5287.2 15969.7 19627.4 20434.0 20468.8 20612.6 1769.3 1853.6 1886.8 1907.1 1980.2 8810.6 8895.5 9159.7 9517.0 12866.9 1629.6 1659.5 1679.3 1732.8 1734.8 45509.5 59801.7 62415.0 62560.7 64967.4 9138.2 9209.0 9625.4 9900.2 10031.8 14085.3 14105.4 14113.6 14132.1 14133.6 6741.1 6914.9 7013.8 7071.7 7072.1 5901.4 5911.5 6026.3 6426.7 6814.4 4162.0 4266.7 4297.1 4297.5 4342.7 1817.1 1864.5 1867.5 1889.9 1913.5 803.6 819.5 832.2 838.2 868.1 16526.3 16848.3 17261.8 17755.3 17759.1 820.2 823.7 827.4 844.9 864.5 9383.5 9497.3 9862.3 9873.9 9901.0 359174.0 371733.0 371791.0 372197.0 372761.0 46959.3 49703.0 68602.0 74990.0 77819.0 812.5 862.4 881.7 885.9 887.2 10778.5 13641.9 14925.5 16143.3 16253.8 32278.0 32921.5 34380.1 36889.0 38512.6 43071.0 47079.9 48083.8 48244.0 51260.2 5159.7 7061.3 7245.7 7708.8 8065.4 9974.5 11331.5 11387.4 11804.4 12143.0 9419.2 9818.8 10060.3 10580.4 10602.5 8235.5 8403.8 9093.6 9562.9 10877.2 8504.6 8594.8 9154.5 9208.8 9306.3 6741.5 7124.0 7197.4 7255.7 7391.4 7447.3 8836.8 9039.3 9398.1 9879.1 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | [#3] mootools.html Cycles:180 Average:5026.72 Median:5201.72 stddev:2811.65 (54.1%) stddev-sans-first:2805.74 17:22:19 INFO - PROCESS | 23793 | Values: 1319.4 1362.2 1395.5 1601.7 1620.8 6577.5 6813.7 7230.0 7749.3 7797.4 7369.3 7667.8 7699.2 7835.1 7846.2 2135.5 2145.6 2174.3 2177.1 2177.8 1804.1 2066.2 2082.3 2180.5 2193.1 1849.6 2119.8 2208.6 2211.3 2230.3 2107.7 2122.3 2122.5 2125.2 2131.9 2075.7 2119.4 2124.3 2125.1 2127.9 7861.9 7901.2 7917.2 7923.5 7927.5 4489.8 4633.9 4642.4 4644.5 4644.7 2718.9 2788.6 2846.9 2847.7 2866.0 870.2 872.4 895.2 904.8 908.5 10093.4 10098.2 10103.9 10166.8 10179.2 3808.5 3890.6 4098.8 4118.5 4179.1 8716.5 8727.8 8731.8 8732.9 8739.3 4516.8 4518.8 4521.3 4524.8 4545.4 4045.1 4177.2 4178.9 4180.0 4183.6 3553.6 3572.3 3640.1 3654.5 3657.3 1037.1 1149.8 1165.9 1183.2 1195.5 604.1 606.6 661.0 693.6 755.7 4950.3 5002.4 5191.2 5212.2 5248.2 811.9 827.4 839.3 860.2 870.0 3535.2 3591.9 3727.3 3785.0 3785.5 9246.2 9557.0 9638.2 9677.0 9695.7 9565.1 9570.6 9591.6 9606.0 9612.6 7261.7 7421.9 7436.3 7438.6 7441.2 4862.8 4909.2 4929.6 5357.6 5493.7 8573.7 8657.2 8663.6 8715.6 8767.6 8671.4 8683.9 8754.9 8806.0 8899.9 6372.2 6387.8 6506.8 6524.4 6526.4 7205.4 7264.4 7265.6 7266.9 7268.1 6469.6 6580.0 6603.1 6676.2 6786.2 6538.8 6580.8 6589.2 6611.9 6637.6 5973.7 6047.3 6053.6 6067.1 6073.2 4408.3 4462.8 4508.3 4529.5 4572.4 4448.4 4449.7 4462.8 4702.0 4808.3 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | [#4] prototype.html Cycles:180 Average:4092.29 Median:4641.24 stddev:1201.14 (25.9%) stddev-sans-first:1170.13 17:22:19 INFO - PROCESS | 23793 | Values: 291.2 295.4 301.8 304.0 304.9 4773.7 4784.3 4789.9 4815.3 4815.9 4682.2 4741.5 4766.9 4769.9 4780.2 3784.1 3784.8 3786.7 3788.7 3792.5 3491.2 3777.0 3780.2 3800.4 3817.2 3699.0 3715.7 3731.1 3731.5 3742.9 3682.6 3714.2 3715.1 3721.3 3721.8 3081.4 3150.8 3159.5 3266.6 3278.2 4580.7 4595.4 4603.9 4609.0 4622.8 4184.4 4193.5 4198.1 4206.7 4226.0 4622.6 4719.0 4918.0 4962.7 4983.2 3527.9 3529.1 3541.5 3542.2 3570.6 5162.6 5185.2 5185.9 5202.7 5207.7 3545.3 3613.4 3616.4 3619.2 3629.7 3627.7 3663.7 3673.7 3680.6 3681.7 4163.9 4166.0 4166.3 4183.6 4193.2 4932.6 4951.0 4952.9 4970.3 4976.3 1202.6 1258.5 1259.1 1261.3 1265.7 804.2 813.9 819.2 823.6 832.4 3929.2 3949.6 3974.2 3981.3 3988.7 4514.9 4520.6 4541.7 4546.9 4553.7 3960.9 3971.5 3972.9 3981.2 3995.5 2420.6 2439.9 2522.8 2698.5 2714.9 4659.7 4706.2 4777.4 4860.8 4888.8 5183.5 5203.9 5218.8 5237.0 5240.0 4835.2 4835.2 4842.9 4847.9 4859.3 4989.4 5077.8 5090.1 5132.3 5139.3 4988.4 5016.3 5030.2 5030.3 5030.9 4859.7 4872.2 4876.8 4881.2 4912.3 3525.9 3593.0 3622.7 3629.9 3644.0 5106.6 5122.2 5124.3 5124.7 5141.7 5020.2 5043.2 5050.3 5052.7 5052.9 4765.5 5005.3 5027.1 5036.1 5054.7 4925.8 4936.3 4937.9 4941.1 4965.0 5046.7 5067.3 5071.4 5074.0 5076.2 4783.7 4877.1 4889.5 4901.8 4911.7 17:22:19 INFO - PROCESS | 23793 | 17:22:19 INFO - PROCESS | 23793 | [#5] yui.html Cycles:180 Average:17809.86 Median:437.77 stddev:26421.07 (6035.4%) stddev-sans-first:26463.71 17:22:19 INFO - PROCESS | 23793 | Values: 631.9 681.1 714.3 734.4 736.3 12940.2 14203.3 14338.4 14347.1 14386.1 12466.0 12649.5 12669.2 12693.8 12700.0 606.7 621.7 742.3 743.4 769.9 770.9 770.9 772.7 773.1 773.3 813.3 819.8 821.8 821.9 822.0 633.0 647.0 767.7 776.4 785.1 585.5 585.6 586.1 586.2 586.5 12408.6 12409.8 12424.1 12437.6 12440.3 12351.2 12483.1 12680.8 12900.4 13178.4 11018.2 11273.7 11493.7 11601.0 12291.8 3807.9 3830.0 3830.1 3865.5 3903.7 56621.0 57028.7 57577.4 58310.0 65788.3 9573.9 9791.2 9908.7 9954.8 10025.4 16689.5 16698.0 16881.6 17009.1 17144.7 6152.0 6160.5 6238.9 6242.7 6314.1 3409.2 3417.9 3424.1 3460.9 3476.5 2698.7 2770.5 2791.9 2797.1 2799.2 442.9 444.6 447.8 453.2 458.0 442.4 450.5 473.5 524.0 524.4 6599.2 6797.2 6880.3 6977.7 7185.0 433.1 473.2 515.7 558.8 559.7 3431.5 3517.4 3580.5 3759.8 3871.8 100595.0 102738.0 103102.0 103341.5 103804.5 90275.0 91455.5 91665.5 91852.0 92186.0 78455.2 79200.0 80018.0 80608.2 80883.2 6643.2 7504.3 8040.3 8230.8 8411.5 29328.5 37115.3 39149.9 40237.2 43100.4 60696.7 62091.4 63103.0 63323.0 63510.0 10299.3 10329.7 10413.4 10626.0 10821.5 12126.1 12510.2 12726.8 12817.6 13027.7 11024.5 11160.7 11599.7 11608.1 11670.9 11666.8 11756.8 11960.5 12359.0 12509.5 10968.1 11357.3 11466.7 11503.1 12025.1 9795.4 10137.0 10229.2 10358.8 10579.6 8108.6 8806.4 9192.4 9521.8 9581.5 17:22:19 INFO - PROCESS | 23793 | -------- Summary: end -------- 17:22:19 INFO - PROCESS | 23793 | 17:22:20 INFO - TEST-INFO | 23793: exit 0 17:22:20 INFO - TEST-OK | dromaeo_css | took 1122364ms 17:22:20 INFO - TEST-START | kraken 17:22:20 INFO - operating with platform_type : linux_ 17:22:20 INFO - Initialising browser for kraken test... 17:22:20 INFO - TEST-INFO | started process 24102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFRwF1/profile http://localhost:58269/getInfo.html) 17:22:25 INFO - PROCESS | 24102 | __metrics Screen width/height:1600/1200 17:22:25 INFO - PROCESS | 24102 | colorDepth:24 17:22:25 INFO - PROCESS | 24102 | Browser inner width/height: 1024/697 17:22:25 INFO - PROCESS | 24102 | __metrics 17:22:25 INFO - PROCESS | 24102 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:22:25 INFO - PROCESS | 24102 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:22:26 INFO - PROCESS | 24102 | console.error: PushService: 17:22:26 INFO - PROCESS | 24102 | stateChangeProcessEnqueue: Error transitioning state 17:22:26 INFO - PROCESS | 24102 | UnknownError 17:22:27 INFO - TEST-INFO | 24102: exit 0 17:22:27 INFO - Browser initialized. 17:22:27 INFO - Running cycle 1/1 for kraken test... 17:22:27 INFO - TEST-INFO | started process 24184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFRwF1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:39 INFO - PROCESS | 24184 | RSS: Main: 174944256 17:22:39 INFO - PROCESS | 24184 | 17:22:42 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58269/tests/kraken/driver.html?testName=audio-beat-detection) 17:22:43 INFO - PROCESS | 24184 | RSS: Main: 232759296 17:22:43 INFO - PROCESS | 24184 | 17:22:45 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58269/tests/kraken/driver.html?testName=audio-dft) 17:22:46 INFO - PROCESS | 24184 | RSS: Main: 218488832 17:22:46 INFO - PROCESS | 24184 | 17:22:49 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58269/tests/kraken/driver.html?testName=audio-fft) 17:22:50 INFO - PROCESS | 24184 | RSS: Main: 300290048 17:22:50 INFO - PROCESS | 24184 | 17:22:52 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58269/tests/kraken/driver.html?testName=audio-oscillator) 17:22:53 INFO - PROCESS | 24184 | RSS: Main: 211120128 17:22:53 INFO - PROCESS | 24184 | 17:22:55 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:56 INFO - PROCESS | 24184 | RSS: Main: 213991424 17:22:56 INFO - PROCESS | 24184 | 17:22:59 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58269/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:59 INFO - PROCESS | 24184 | RSS: Main: 250068992 17:22:59 INFO - PROCESS | 24184 | 17:23:03 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58269/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:04 INFO - PROCESS | 24184 | RSS: Main: 244219904 17:23:04 INFO - PROCESS | 24184 | 17:23:06 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58269/tests/kraken/driver.html?testName=json-parse-financial) 17:23:07 INFO - PROCESS | 24184 | RSS: Main: 246460416 17:23:07 INFO - PROCESS | 24184 | 17:23:09 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:23:09 INFO - PROCESS | 24184 | RSS: Main: 210374656 17:23:09 INFO - PROCESS | 24184 | 17:23:11 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:23:12 INFO - PROCESS | 24184 | RSS: Main: 217890816 17:23:12 INFO - PROCESS | 24184 | 17:23:14 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:23:15 INFO - PROCESS | 24184 | RSS: Main: 226926592 17:23:15 INFO - PROCESS | 24184 | 17:23:17 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:23:18 INFO - PROCESS | 24184 | RSS: Main: 235323392 17:23:18 INFO - PROCESS | 24184 | 17:23:21 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:23:22 INFO - PROCESS | 24184 | RSS: Main: 232394752 17:23:22 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | Cycle 1(1): loaded http://localhost:58269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58269/tests/kraken/driver.html?testName=ai-astar) 17:23:24 INFO - PROCESS | 24184 | RSS: Main: 281563136 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | __start_tp_report 17:23:24 INFO - PROCESS | 24184 | _x_x_mozilla_page_load 17:23:24 INFO - PROCESS | 24184 | _x_x_mozilla_page_load_details 17:23:24 INFO - PROCESS | 24184 | |i|pagename|runs| 17:23:24 INFO - PROCESS | 24184 | |0;ai-astar;115;115;113;116;114;115;114;113;113;112 17:23:24 INFO - PROCESS | 24184 | |1;audio-beat-detection;157;126;127;172;132;131;136;132;172;132 17:23:24 INFO - PROCESS | 24184 | |2;audio-dft;165;162;162;165;165;164;163;161;162;161 17:23:24 INFO - PROCESS | 24184 | |3;audio-fft;76;76;75;104;76;77;76;77;100;76 17:23:24 INFO - PROCESS | 24184 | |4;audio-oscillator;85;83;131;84;83;83;112;84;83;128 17:23:24 INFO - PROCESS | 24184 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 17:23:24 INFO - PROCESS | 24184 | |6;imaging-darkroom;147;146;146;146;147;147;147;146;146;146 17:23:24 INFO - PROCESS | 24184 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 17:23:24 INFO - PROCESS | 24184 | |8;json-parse-financial;65;64;65;64;66;64;65;64;66;66 17:23:24 INFO - PROCESS | 24184 | |9;json-stringify-tinderbox;67;67;66;66;66;67;66;67;66;67 17:23:24 INFO - PROCESS | 24184 | |10;stanford-crypto-aes;84;82;84;89;82;92;84;84;83;83 17:23:24 INFO - PROCESS | 24184 | |11;stanford-crypto-ccm;150;140;149;138;138;138;150;138;183;140 17:23:24 INFO - PROCESS | 24184 | |12;stanford-crypto-pbkdf2;179;183;181;181;183;180;175;176;180;179 17:23:24 INFO - PROCESS | 24184 | |13;stanford-crypto-sha256-iterative;70;75;70;72;73;70;71;72;69;69 17:23:24 INFO - PROCESS | 24184 | __end_tp_report 17:23:24 INFO - PROCESS | 24184 | __start_cc_report 17:23:24 INFO - PROCESS | 24184 | _x_x_mozilla_cycle_collect,2034 17:23:24 INFO - PROCESS | 24184 | __end_cc_report 17:23:24 INFO - PROCESS | 24184 | __startTimestamp1476318204478__endTimestamp 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | ------- Summary: start ------- 17:23:24 INFO - PROCESS | 24184 | Number of tests: 14 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:1.27 17:23:24 INFO - PROCESS | 24184 | Values: 115.0 115.0 113.0 116.0 114.0 115.0 114.0 113.0 113.0 112.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:134.00 stddev:18.14 (13.5%) stddev-sans-first:18.38 17:23:24 INFO - PROCESS | 24184 | Values: 157.0 126.0 127.0 172.0 132.0 131.0 136.0 132.0 172.0 132.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.63 (1.0%) stddev-sans-first:1.56 17:23:24 INFO - PROCESS | 24184 | Values: 165.0 162.0 162.0 165.0 165.0 164.0 163.0 161.0 162.0 161.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:10.97 (14.4%) stddev-sans-first:11.46 17:23:24 INFO - PROCESS | 24184 | Values: 76.0 76.0 75.0 104.0 76.0 77.0 76.0 77.0 100.0 76.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:83.00 stddev:19.97 (24.1%) stddev-sans-first:20.81 17:23:24 INFO - PROCESS | 24184 | Values: 85.0 83.0 131.0 84.0 83.0 83.0 112.0 84.0 83.0 128.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:23:24 INFO - PROCESS | 24184 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:23:24 INFO - PROCESS | 24184 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:23:24 INFO - PROCESS | 24184 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 17:23:24 INFO - PROCESS | 24184 | Values: 65.0 64.0 65.0 64.0 66.0 64.0 65.0 64.0 66.0 66.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 17:23:24 INFO - PROCESS | 24184 | Values: 67.0 67.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 67.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.23 (3.8%) stddev-sans-first:3.42 17:23:24 INFO - PROCESS | 24184 | Values: 84.0 82.0 84.0 89.0 82.0 92.0 84.0 84.0 83.0 83.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:144.50 stddev:13.89 (9.6%) stddev-sans-first:14.67 17:23:24 INFO - PROCESS | 24184 | Values: 150.0 140.0 149.0 138.0 138.0 138.0 150.0 138.0 183.0 140.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:180.50 stddev:2.63 (1.5%) stddev-sans-first:2.77 17:23:24 INFO - PROCESS | 24184 | Values: 179.0 183.0 181.0 181.0 183.0 180.0 175.0 176.0 180.0 179.0 17:23:24 INFO - PROCESS | 24184 | 17:23:24 INFO - PROCESS | 24184 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.91 (2.7%) stddev-sans-first:1.99 17:23:24 INFO - PROCESS | 24184 | Values: 70.0 75.0 70.0 72.0 73.0 70.0 71.0 72.0 69.0 69.0 17:23:24 INFO - PROCESS | 24184 | -------- Summary: end -------- 17:23:24 INFO - PROCESS | 24184 | 17:23:25 INFO - TEST-INFO | 24184: exit 0 17:23:25 INFO - TEST-OK | kraken | took 65329ms 17:23:25 INFO - SUITE-END | took 1187s 17:23:26 INFO - Completed test suite (00:19:47) 17:23:26 INFO - javascript benchmark 17:23:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.4216551275963, 2589.0808762889187, 2621.344663834042, 2634.262406526172, 2648.4173481834, 4518.412606361177, 4594.40272764541, 4731.1956967315555, 4743.383360163179, 4748.952510474895, 4619.1454580902555, 4626.028534007863, 4631.258998560231, 4635.675502714811, 4640.3967484227005, 4234.110836724291, 4256.787160641971, 4262.232798096342, 4288.742675439468, 4290.2706539888295, 4335.371371151197, 4346.217680817452, 4373.453318335208, 4374.168907907503, 4376.081022985161, 4326.870193894189, 4342.869713908588, 4368.213721530124, 4369.847055353063, 4383.517813040563, 4388.605025547684, 4421.734695918255, 4424.579664931826, 4452.487963884146, 4475.239209334389, 4195.496540415139, 4200.4539409876525, 4242.3212286034395, 4342.131573685244, 4346.6522678185665, 4550.072101447501, 4566.26939689648, 4573.0, 4592.288195329729, 4667.649926255511, 4883.8290659826735, 4930.260460930853, 4935.9753201234125, 4937.037277730844, 4975.676581022258, 4931.80272789088, 4959.900801983977, 4967.776450059756, 4980.053789779967, 5016.2224855147515, 4594.74728889911, 4618.076384723069, 4628.074385122922, 4694.037722266995, 4715.056988602293, 5013.373328333958, 5029.899402012013, 5073.010762901199, 5076.111680455905, 5136.948630513722, 4809.831655892097, 4815.061063092663, 4821.590164836029, 4821.662483626183, 4877.195262781673, 4791.688540244873, 4834.6374021948495, 4835.29888166221, 4945.579625731853, 4953.90092198154, 4933.703977761345, 4952.504749525018, 5007.048660754518, 5019.14674505335, 5024.874378140576, 4913.336699545587, 4926.236433352836, 4929.802807887644, 4936.062148191832, 4993.026359859865, 4073.653739432122, 4114.855980040744, 4163.146554956226, 4175.039740859619, 4180.456540649696, 3626.401643728808, 3664.2121943782213, 3670.926581468356, 3671.2290419011774, 3724.3854763964187, 4365.06151177492, 4384.517703052662, 4387.605115539617, 4394.978025109918, 4450.955490445119, 5059.367579052619, 5072.923906141411, 5084.593232541388, 5085.6948583084395, 5139.331886854685, 4246.617804397557, 4293.914121717548, 4299.914001719948, 4344.304911214191, 4367.0, 4491.46102467706, 4497.190505709003, 4516.932246016312, 4549.567791059844, 4554.111948170075, 4786.234202527578, 4795.0, 4799.088173247072, 4802.183628783046, 4847.903041939212, 4846.466888642317, 4912.017596480647, 4918.262260660929, 5060.240963855451, 5069.645124841373, 4724.6692731508465, 4770.260609605517, 4788.257820037899, 4795.328653988375, 4832.299316599003, 4968.2795994579865, 4973.328600638867, 4976.247917029286, 4976.975115124401, 5037.949620503748, 4782.450018247946, 5048.545630893237, 5056.82301119459, 5060.974695126501, 5077.695338279715, 4668.206404911241, 4834.516548345137, 4885.1450996076255, 4885.5358740919555, 4982.725950072636, 4880.316755654282, 4910.680805747615, 4910.779014944264, 4916.237983112624, 4974.776135073858, 4851.975740121276, 4869.513048695102, 4873.829415970424, 4878.780454879468, 4935.75321233944, 4775.6179505638775, 4825.083234185494, 4882.292067650242, 4915.066137433876, 4930.753462326941, 4847.61219102478, 4848.490908454562, 4852.708837469763, 4896.706197628154, 4906.215005599087], "value": 4590.297523811163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.7402194990304, 565.4091474409242, 569.3310360326615, 570.3156212544947, 584.9970750146251, 26682.86658566707, 27406.86296568519, 29189.124326270194, 37652.43521347182, 38413.622092906946, 38195.42706859393, 38631.99999999993, 38644.80677596615, 38663.42004869922, 38686.419703704465, 7452.70189192433, 7613.467057305963, 7616.086069671619, 7620.276073772982, 7625.084989801232, 7393.297636724503, 7480.401567874557, 7481.812954676149, 7495.512791668524, 7534.698612055511, 7541.547507149561, 7580.355669768049, 7584.582847943361, 7588.165301816795, 7591.051118610174, 7529.397648188132, 7561.281678240586, 7563.243675632448, 7568.621568921587, 7578.469507134503, 7540.472166948316, 7581.09026916768, 7585.696572137108, 7594.962025189894, 7605.695772169107, 34815.4777678335, 35114.0, 35213.647863521546, 35263.1184220394, 35325.11687207815, 2872.4975018518535, 3114.5951026366656, 3459.567554055743, 3467.497212904115, 3533.1697051193205, 27551.44897102067, 27652.446951060865, 27790.444191116065, 28972.710272897213, 29023.709762902312, 3035.696430356969, 3103.5810165627577, 3106.1923899785993, 3177.126290270171, 3256.674332566748, 233296.0, 233603.0, 234131.0, 234501.0, 234567.8271608648, 30778.0, 31513.0, 50742.74628626833, 51095.0, 51189.0, 33245.50131748026, 33494.0, 33542.329153416795, 33582.16044598856, 33584.0, 12801.0, 12980.480780768852, 12984.350782460839, 13025.088243822842, 13028.153170044106, 10464.372137671764, 10664.360138391721, 10673.519691613896, 10711.357318560911, 10713.946430267955, 7802.960985195038, 7821.061472623208, 7860.960695196602, 7916.129225785159, 7923.247291507298, 3090.5827713258873, 3097.530765542607, 3106.130283520618, 3123.297258116951, 3175.555422240888, 812.4921923797626, 948.1653001442094, 977.6431602465049, 999.7250756042147, 1001.2140469731372, 26520.52117913288, 27033.72966270312, 27173.456530869273, 27529.86235068852, 27547.31131721683, 930.6137952749533, 949.3829011142674, 961.6105477281712, 961.6153538584482, 983.3313346924017, 13520.661983450493, 14429.85570144306, 14441.205733684537, 14481.0, 14787.408503659733, 354331.0, 356096.0, 357799.0, 358282.0, 358350.0, 48103.5189648106, 48494.3328116957, 48856.75571622119, 48863.0, 48894.51105488971, 1137.2266858536275, 1157.9594714184964, 1158.8609366876028, 1183.2545496337252, 1186.4364426897328, 25751.871240643675, 26298.73701262963, 26693.19920402391, 26968.460630787667, 27295.86352068227, 41495.377569335884, 41744.3738343919, 41863.0, 41870.06909516427, 41882.0, 319944.0, 324126.0, 324205.0, 324626.0, 324697.0, 24794.25617231486, 25123.371915701522, 25294.11470598594, 25401.872990635668, 25494.617580735932, 40517.797411012754, 40554.79722601486, 41463.58536414597, 41487.377689335284, 42199.367009495494, 34839.825800870836, 34887.0, 35049.123771905906, 35366.0, 35514.467282991296, 34453.31093378068, 34503.30993380068, 34854.82572587121, 34884.30231395409, 35127.29745405129, 25153.38637533105, 31665.20836979094, 32021.35957280795, 34740.652593474755, 36479.0, 29370.853145734134, 31880.68119318777, 31981.200469988435, 31991.360172796878, 32151.517727233644, 24367.51264974726, 24392.146274880295, 24876.50246995086, 25275.87362063178, 25317.367065823502], "value": 15868.554402481583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7339835026204, 349.41821866592124, 369.99260014799705, 373.74585282008235, 380.7410960546829, 12206.81689774653, 12569.685757856047, 12755.071449985013, 12826.422810973505, 17182.226799794007, 16142.354305827783, 16319.265633046512, 16723.247453864577, 16831.663366732657, 16862.915685421587, 4786.497417771127, 4881.219004959189, 4994.325766021595, 5025.899482010358, 5057.974710126463, 3562.3765840977853, 4955.182394904837, 5044.495550444963, 5044.873878153057, 5049.4698056704065, 3724.664780169784, 5556.416576259495, 5815.82552523425, 5826.193879897245, 5915.467607915287, 5731.541476681856, 5905.468507834294, 5920.141579470953, 5920.822375328747, 5932.9406705932815, 5259.316288882421, 5284.5772338212855, 5284.9735751320995, 5285.101532739443, 5287.233351164098, 15969.680606387807, 19627.411177664693, 20434.0, 20468.795312046837, 20612.5877482451, 1769.2834402067056, 1853.629274145163, 1886.76415448069, 1907.1131923655428, 1980.1584326661255, 8810.559472026373, 8895.4662720237, 9159.679411220575, 9517.0, 12866.87133128666, 1629.5926018495377, 1659.5436255029963, 1679.3450554283838, 1732.7574139620463, 1734.7831521059868, 45509.544904550865, 59801.7009914952, 62415.0, 62560.687196564184, 64967.350326496606, 9138.223251023604, 9208.953955230316, 9625.374350667184, 9900.158486528726, 10031.849522257173, 14085.295735213198, 14105.435782568582, 14113.57659270203, 14132.081414708011, 14133.646658833406, 6741.1236539249585, 6914.9308506915295, 7013.754518591825, 7071.717131314793, 7072.115985501812, 5901.439363260483, 5911.527077833763, 6026.276846778414, 6426.710798014101, 6814.420774234246, 4162.042730172077, 4266.679999000087, 4297.09760950204, 4297.484301883794, 4342.69601127918, 1817.1277786662213, 1864.4779461750732, 1867.5237814357524, 1889.8960557169487, 1913.4929243750416, 803.5901690138072, 819.4878201124297, 832.2426591801552, 838.2497664590157, 868.1188593577524, 16526.338946442007, 16848.326066957183, 17261.827381726274, 17755.289788408576, 17759.112044397727, 820.1634332980445, 823.6828820903995, 827.3505298340893, 844.8817165596821, 864.4726716702806, 9383.5308234588, 9497.287703422271, 9862.260330475243, 9873.91526036223, 9901.0, 359174.0, 371733.0, 371791.0, 372197.0, 372761.0, 46959.29561056587, 49703.0, 68602.0, 74990.0, 77819.0, 812.5490352854105, 862.4307956748515, 881.6737807011318, 885.93798434109, 887.2325438495784, 10778.461076945965, 13641.931790340985, 14925.477608283658, 16143.273552689921, 16253.756193656867, 32278.0, 32921.50617740688, 34380.14049648779, 36889.0, 38512.61487385202, 43071.0, 47079.85280680649, 48083.75958120187, 48244.0, 51260.23109653433, 5159.690418574897, 7061.293870612898, 7245.746398876014, 7708.8458230836195, 8065.395095367753, 9974.451405172495, 11331.546738130712, 11387.373694446886, 11804.409779511161, 12143.02855771554, 9419.246460283024, 9818.803623927624, 10060.295779295378, 10580.41807700584, 10602.522886469973, 8235.50586964784, 8403.83192336162, 9093.590788414405, 9562.904370956201, 10877.238593298393, 8504.574771261536, 8594.78513037154, 9154.496502692416, 9208.815823683623, 9306.255499560155, 6741.494387920828, 7124.0, 7197.352238298578, 7255.673494692646, 7391.40868730511, 7447.292507211806, 8836.779080523038, 9039.322050846082, 9398.107179817905, 9879.110880020833], "value": 7797.562249507664, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.3535167767798, 1362.2031111799597, 1395.539471974248, 1601.6876709041726, 1620.7649890765847, 6577.50668699847, 6813.659317034153, 7229.963850180755, 7749.263819937111, 7797.415193860462, 7369.336759691627, 7667.769966900988, 7699.153093159762, 7835.098963619185, 7846.176151504095, 2135.540858715376, 2145.6459684152137, 2174.2716190076344, 2177.0747432341273, 2177.7822217778253, 1804.0979510244877, 2066.1838573763353, 2082.2607974169177, 2180.5202855371795, 2193.0679461228992, 1849.574597842497, 2119.8198153157, 2208.5914105890383, 2211.3255457085584, 2230.3309007297826, 2107.6838474228834, 2122.299641118435, 2122.490602255463, 2125.224293133003, 2131.904064317094, 2075.6575165097893, 2119.4383488375593, 2124.3414541492034, 2125.0968338456096, 2127.8936053197276, 7861.921380786233, 7901.20987901211, 7917.247861453153, 7923.5245885246495, 7927.484713493662, 4489.753063581502, 4633.884152896171, 4642.442906851165, 4644.489106198315, 4644.698094623873, 2718.877650505732, 2788.5538313869683, 2846.9288267793263, 2847.700991395894, 2866.0, 870.2298465857698, 872.4067634008871, 895.2211575928918, 904.8099899021213, 908.5457271364318, 10093.39439633617, 10098.192144628412, 10103.949480252551, 10166.796664066751, 10179.18566514677, 3808.5239345081864, 3890.6109389060866, 4098.836046558164, 4118.5057793065025, 4179.1432756284885, 8716.520591367409, 8727.825443491094, 8731.781705457288, 8732.8690069649, 8739.344549158839, 4516.774161291923, 4518.796654150571, 4521.276595744665, 4524.773761311922, 4545.36364908913, 4045.130296986103, 4177.227212965611, 4178.8537401190815, 4179.975905903073, 4183.644390226865, 3553.573571171424, 3572.285542891432, 3640.1445660269815, 3654.488371627974, 3657.2868290683596, 1037.0821822686976, 1149.827525871126, 1165.877582853805, 1183.2486371154207, 1195.5277665322149, 604.1089393145076, 606.5996442348029, 660.9655888534428, 693.639307560066, 755.720383458124, 4950.2822090796635, 5002.424721157114, 5191.196753753006, 5212.244224587489, 5248.2390053442805, 811.939104567148, 827.4042689263721, 839.3159574946399, 860.2429861721645, 869.9782505437288, 3535.1869070113503, 3591.856325746941, 3727.2918145552258, 3784.9810750946067, 3785.5078839750654, 9246.167844893991, 9557.044295570387, 9638.180754635934, 9676.951615241878, 9695.66065187715, 9565.091316324939, 9570.56932438042, 9591.568379422943, 9606.039396060478, 9612.567434465465, 7261.673224704901, 7421.925780742124, 7436.330730234196, 7438.5536867788105, 7441.181470038291, 4862.781174847211, 4909.189983652657, 4929.580985616263, 5357.598180136583, 5493.670379777226, 8573.699920502753, 8657.22085012352, 8663.566821659018, 8715.603209117544, 8767.649294028422, 8671.393002489765, 8683.86974195375, 8754.912450875665, 8806.0, 8899.866502002345, 6372.235331760218, 6387.840303992437, 6506.772262970773, 6524.380183882524, 6526.379993900572, 7205.423566114593, 7264.382527485011, 7265.564066156047, 7266.89099663516, 7268.0914885639295, 6469.611823290617, 6580.0097688373935, 6603.075569420381, 6676.165479315086, 6786.151731033621, 6538.83652908662, 6580.8354791130605, 6589.17635295588, 6611.900821487586, 6637.568558043712, 5973.701314934323, 6047.334793172659, 6053.576249662481, 6067.089936509559, 6073.240844894388, 4408.336488075081, 4462.821487140478, 4508.346289788028, 4529.456465224194, 4572.382728331632, 4448.4439445069365, 4449.7330160190495, 4462.7768611568645, 4701.9529804701515, 4808.326834243278], "value": 4030.302542475097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.17597199924217, 295.4386665335863, 301.79025577223825, 303.96200474940633, 304.9070033639739, 4773.6897101688455, 4784.282357646351, 4789.856304310872, 4815.349927759756, 4815.903681926359, 4682.180618391785, 4741.525847415265, 4766.903612169203, 4769.8807529811775, 4780.211265141247, 3784.12965018046, 3784.7888675623813, 3786.678132358753, 3788.6590206881374, 3792.5448946126435, 3491.1970246843243, 3776.9811150944206, 3780.2439512097553, 3800.448934904437, 3817.2174704185577, 3698.981505092471, 3715.7398982071268, 3731.1045349116152, 3731.496248006525, 3742.9438558421643, 3682.5949145593963, 3714.1614900624363, 3715.1269451678836, 3721.292954338694, 3721.832517536717, 3081.383723255358, 3150.84245787712, 3159.526071089332, 3266.6243382011135, 3278.246003419203, 4580.656450766206, 4595.402597662316, 4603.930941035887, 4608.953910460886, 4622.8150873965005, 4184.4141820145205, 4193.454850869368, 4198.13938142683, 4206.705530612859, 4225.985763416788, 4622.560856718606, 4718.952810471886, 4918.000019987805, 4962.702237865739, 4983.206045823501, 3527.876524321662, 3529.100079479742, 3541.451075083366, 3542.220711443478, 3570.6072332043454, 5162.586993040548, 5185.196294574347, 5185.948140518622, 5202.661826981272, 5207.6875387476875, 3545.290941811648, 3613.4100995561867, 3616.385214513539, 3619.167591453928, 3629.6914762245506, 3627.7279204059273, 3663.7176988054503, 3673.687736542424, 3680.582975554431, 3681.668649821529, 4163.875083747493, 4165.958340416618, 4166.312558427886, 4183.560726123713, 4193.20329137469, 4932.630052746058, 4950.950490495049, 4952.876178095505, 4970.304157417964, 4976.303317535548, 1202.6211743300832, 1258.4777317413354, 1259.1123258103016, 1261.3188878005774, 1265.7405231927432, 804.2399932064143, 813.9186081391932, 819.1644522587047, 823.6211342782267, 832.4422636833336, 3929.2141571685206, 3949.565547789741, 3974.20515896816, 3981.3032719274593, 3988.720789544704, 4514.864554063383, 4520.570545798144, 4541.72749635023, 4546.909061818745, 4553.702194874445, 3960.940585891214, 3971.5035620547433, 3972.940405893914, 3981.243563722883, 3995.5405128410025, 2420.649005894171, 2439.8536087834786, 2522.7638457155863, 2698.46030793842, 2714.8914043438435, 4659.673822832437, 4706.1999460091865, 4777.4473296178185, 4860.781264843091, 4888.82889098887, 5183.533481986564, 5203.895922081537, 5218.808100597758, 5236.973815130977, 5240.0, 4835.153848076643, 4835.178019736653, 4842.854714358575, 4847.927281090787, 4859.343988561499, 4989.355641510006, 5077.826358525921, 5090.1495162709, 5132.2814805926455, 5139.331886854835, 4988.401391833003, 5016.347874776256, 5030.195168772979, 5030.320906677552, 5030.949690503195, 4859.708417494961, 4872.1717308057005, 4876.805182730253, 4881.194602890625, 4912.287718280901, 3525.894223173309, 3592.964070359263, 3622.6558476944647, 3629.909252268714, 3644.034330902366, 5106.591472682102, 5122.206058061007, 5124.30821839047, 5124.721536817085, 5141.665791723526, 5020.221865610836, 5043.218301163325, 5050.3434553507805, 5052.671576347526, 5052.877791327578, 4765.475797662185, 5005.273180752634, 5027.069992051483, 5036.143855544639, 5054.721990290423, 4925.778339974638, 4936.259561065869, 4937.876553086202, 4941.135301322326, 4965.006998600222, 5046.747662616928, 5067.315912351785, 5071.377159309133, 5073.985202959349, 5076.213186956028, 4783.736894470838, 4877.097736918681, 4889.462159162418, 4901.828436004723, 4911.68074075184], "value": 3711.583051203225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.9368063193681, 681.1349586025744, 714.3499415531867, 734.3904559215849, 736.3152268390395, 12940.2235865848, 14203.289835508234, 14338.426462941496, 14347.13917164971, 14386.1368317901, 12466.002719782418, 12649.494020239203, 12669.23984560927, 12693.809592856114, 12699.999999999976, 606.6633018674634, 621.6891554222889, 742.2874040920696, 743.4015617427982, 769.8806684963839, 770.8535378278137, 770.8650986077442, 772.6677528662673, 773.1186447449884, 773.3156156801243, 813.2843098073716, 819.8278361544083, 821.843849668561, 821.8520666280067, 822.0382152881114, 633.0377825704926, 646.9838254043663, 767.6852490478877, 776.3866545429104, 785.081454697999, 585.5315747402061, 585.5871610514577, 586.085706298172, 586.237890742038, 586.4692453329743, 12408.56570020045, 12409.813852792215, 12424.130310878241, 12437.564685236064, 12440.315782631951, 12351.19717218378, 12483.126181167321, 12680.80978785319, 12900.419481123372, 13178.406971686298, 11018.228723989325, 11273.661790146309, 11493.712657183554, 11601.0, 12291.754164916742, 3807.9428808567895, 3829.9808500957597, 3830.1382189007527, 3865.4781604483314, 3903.668188204006, 56621.0, 57028.71485642545, 57577.424225757626, 58310.0, 65788.3421165787, 9573.90426095744, 9791.167750741124, 9908.653197138066, 9954.800903982024, 10025.398476091312, 16689.491098471604, 16698.0, 16881.577960551083, 17009.149542522824, 17144.65710685804, 6152.0, 6160.537959652955, 6238.906416403757, 6242.692086644645, 6314.116023756677, 3409.2499650076943, 3417.8974630761118, 3424.143964008998, 3460.8596811342504, 3476.478528220787, 2698.743619356158, 2770.48745981994, 2791.9302017449727, 2797.1328888044363, 2799.1882354117483, 442.8627125591077, 444.5643269595814, 447.7604481602327, 453.17295934918906, 457.97939092740904, 442.4403975984616, 450.5359479735877, 473.46734923211386, 523.9703981675949, 524.3864678326368, 6599.241087274929, 6797.150356205474, 6880.311968803079, 6977.720891164398, 7184.9640751795905, 433.10347580508045, 473.15777915310804, 515.7060475528988, 558.8463172627479, 559.6781850436015, 3431.4852772083887, 3517.3668739627115, 3580.516630254934, 3759.812009399519, 3871.7676939383728, 100595.0, 102738.0, 103102.0, 103341.48329258306, 103804.48097759463, 90275.0, 91455.54272228596, 91665.54167229254, 91852.0, 92186.0, 78455.21544784593, 79200.0, 80018.0, 80608.19391806124, 80883.19116808756, 6643.243054132481, 7504.287092726182, 8040.276375126266, 8230.83538329242, 8411.45325553837, 29328.542779085314, 37115.25769484649, 39149.91051163331, 40237.19525609413, 43100.353494696974, 60696.696516517135, 62091.37908620856, 63103.0, 63323.0, 63510.04734929072, 10299.330543514647, 10329.690109296733, 10413.375197487872, 10626.0, 10821.51303191374, 12126.090543209471, 12510.249385036926, 12726.809097863354, 12817.615471535868, 13027.674308142372, 11024.5038973248, 11160.665180044612, 11599.710007249887, 11608.129390295593, 11670.94164529172, 11666.824997625212, 11756.764864702487, 11960.521579136737, 12359.0, 12509.499620015098, 10968.062879315745, 11357.318560886373, 11466.656000320003, 11503.137264705349, 12025.098117641386, 9795.412275263507, 10137.0, 10229.232807539316, 10358.844617330595, 10579.576816927236, 8108.554029528433, 8806.383553151474, 9192.448453092837, 9521.761955951157, 9581.473018984023], "value": 6328.543328567022, "unit": "score"}], "name": "dromaeo_css", "value": 6143.710737321317, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 113.0, 116.0, 114.0, 115.0, 114.0, 113.0, 113.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 127.0, 172.0, 132.0, 131.0, 136.0, 132.0, 172.0, 132.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 165.0, 165.0, 164.0, 163.0, 161.0, 162.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 104.0, 76.0, 77.0, 76.0, 77.0, 100.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 131.0, 84.0, 83.0, 83.0, 112.0, 84.0, 83.0, 128.0], "value": 95.6, "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": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 64.0, 66.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 89.0, 82.0, 92.0, 84.0, 84.0, 83.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 140.0, 149.0, 138.0, 138.0, 138.0, 150.0, 138.0, 183.0, 140.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 181.0, 181.0, 183.0, 180.0, 175.0, 176.0, 180.0, 179.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 70.0, 72.0, 73.0, 70.0, 71.0, 72.0, 69.0, 69.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1567.2, "alertThreshold": 2.0}]} 17:23:26 INFO - Return code: 0 17:23:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:23:26 INFO - # TBPL SUCCESS # 17:23:26 INFO - Running post-action listener: _resource_record_post_action 17:23:26 INFO - [mozharness: 2016-10-13 00:23:26.245935Z] Finished run-tests step (success) 17:23:26 INFO - Running post-run listener: _resource_record_post_run 17:23:26 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392204288; Read time: 12; Write time: 280840 17:23:26 INFO - TinderboxPrint: CPU usage
13.1% 17:23:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:23:26 INFO - TinderboxPrint: I/O write bytes / time
392,204,288 / 280,840 17:23:26 INFO - TinderboxPrint: CPU idle
8,351.1 (86.9%) 17:23:26 INFO - TinderboxPrint: CPU user
1,205.5 (12.5%) 17:23:26 INFO - TinderboxPrint: Swap in / out
0 / 0 17:23:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101552128; Read time: 0; Write time: 88320 17:23:26 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290652160; Read time: 0; Write time: 192520 17:23:26 INFO - Running post-run listener: _upload_blobber_files 17:23:26 INFO - Blob upload gear active. 17:23:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:23:26 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 17:23:26 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'] 17:23:26 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 17:23:27 INFO - (blobuploader) - INFO - Open directory for files ... 17:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:23:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:30 INFO - (blobuploader) - INFO - Done attempting. 17:23:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:23:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:23:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:31 INFO - (blobuploader) - INFO - Done attempting. 17:23:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:23:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:23:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:23:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:23:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:23:32 INFO - (blobuploader) - INFO - Done attempting. 17:23:32 INFO - (blobuploader) - INFO - Iteration through files over. 17:23:32 INFO - Return code: 0 17:23:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:23:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:23:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9496d4d1a4e422fc78bfdab3aae0229d32a26379135c4b2693e1972c0ca3b5332fc4ddcff938d3dc83bc552834f6cd65dd2865d4e3ad2c711bae74968adc4976", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9c9df8b0b24b735f11a0d85d806b49565534735de969d3a881111262d33d595d0cc8e472313e00f1d022627bf1ace7cbffc24ca94270deed303e18ed26e26bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1478265a4d587baec032297e1401d9026685068cbcf122abca60413559a01052db99948591a2f858b421d5de5c091e0492ecb3e17719fe56aba608430c22176e"} 17:23:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:23:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:23:32 INFO - Contents: 17:23:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9496d4d1a4e422fc78bfdab3aae0229d32a26379135c4b2693e1972c0ca3b5332fc4ddcff938d3dc83bc552834f6cd65dd2865d4e3ad2c711bae74968adc4976", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9c9df8b0b24b735f11a0d85d806b49565534735de969d3a881111262d33d595d0cc8e472313e00f1d022627bf1ace7cbffc24ca94270deed303e18ed26e26bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1478265a4d587baec032297e1401d9026685068cbcf122abca60413559a01052db99948591a2f858b421d5de5c091e0492ecb3e17719fe56aba608430c22176e"} 17:23:32 INFO - Running post-run listener: copy_logs_to_upload_dir 17:23:32 INFO - Copying logs to upload dir... 17:23:32 INFO - mkdir: /builds/slave/test/build/upload/logs 17:23:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.560381 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-12 17:23:31.993896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 17:23:31.997625) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672 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/9496d4d1a4e422fc78bfdab3aae0229d32a26379135c4b2693e1972c0ca3b5332fc4ddcff938d3dc83bc552834f6cd65dd2865d4e3ad2c711bae74968adc4976", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9c9df8b0b24b735f11a0d85d806b49565534735de969d3a881111262d33d595d0cc8e472313e00f1d022627bf1ace7cbffc24ca94270deed303e18ed26e26bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1478265a4d587baec032297e1401d9026685068cbcf122abca60413559a01052db99948591a2f858b421d5de5c091e0492ecb3e17719fe56aba608430c22176e"} build_url:https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/EyDniJv1Qsq9BU2WgHlXqA/artifacts/public/build/firefox-52.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/9496d4d1a4e422fc78bfdab3aae0229d32a26379135c4b2693e1972c0ca3b5332fc4ddcff938d3dc83bc552834f6cd65dd2865d4e3ad2c711bae74968adc4976", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c9c9df8b0b24b735f11a0d85d806b49565534735de969d3a881111262d33d595d0cc8e472313e00f1d022627bf1ace7cbffc24ca94270deed303e18ed26e26bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1478265a4d587baec032297e1401d9026685068cbcf122abca60413559a01052db99948591a2f858b421d5de5c091e0492ecb3e17719fe56aba608430c22176e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 17:23:32.023337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:23:32.023678) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476316960.954125-1870215672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:23:32.109368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 17:23:32.109719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 17:23:32.110060) ========= ========= Total master_lag: 0.15 =========